builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1462566456.36 results: success (0) buildid: 20160506104633 builduid: 05cc5641ad3947bab3d5732d96f698b4 revision: 40745bcb866ff190c40d9a58cb3006a1c58031ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.360173) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.360997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.361572) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.375915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.376319) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 13:27:36-- 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% 212M=0s 2016-05-06 13:27:37 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.409069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.801214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.801964) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015471 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:36.855450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 13:27:36.856245) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 40745bcb866ff190c40d9a58cb3006a1c58031ba --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 40745bcb866ff190c40d9a58cb3006a1c58031ba --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=6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 13:27:37,327 truncating revision to first 12 chars 2016-05-06 13:27:37,327 Setting DEBUG logging. 2016-05-06 13:27:37,327 attempt 1/10 2016-05-06 13:27:37,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/40745bcb866f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 13:27:38,322 unpacking tar archive at: mozilla-inbound-40745bcb866f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.285712 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 13:27:38.156465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:38.156869) ========= script_repo_revision: 40745bcb866ff190c40d9a58cb3006a1c58031ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:38.157343) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:38.157701) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 13:27:38.168818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-06 13:27:38.169532) ========= /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=6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:27:38 INFO - MultiFileLogger online at 20160506 13:27:38 in /builds/slave/test 13:27:38 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 13:27:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:27:38 INFO - {'append_to_log': False, 13:27:38 INFO - 'base_work_dir': '/builds/slave/test', 13:27:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:27:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:27:38 INFO - 'branch': 'Mozilla-Inbound', 13:27:38 INFO - 'buildbot_json_path': 'buildprops.json', 13:27:38 INFO - 'config_files': ('talos/linux_config.py',), 13:27:38 INFO - 'default_actions': ('clobber', 13:27:38 INFO - 'read-buildbot-config', 13:27:38 INFO - 'download-and-extract', 13:27:38 INFO - 'populate-webroot', 13:27:38 INFO - 'create-virtualenv', 13:27:38 INFO - 'install', 13:27:38 INFO - 'run-tests'), 13:27:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:27:38 INFO - 'download_minidump_stackwalk': True, 13:27:38 INFO - 'download_symbols': 'ondemand', 13:27:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:27:38 INFO - 'tooltool.py': '/tools/tooltool.py', 13:27:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:27:38 INFO - '/tools/misc-python/virtualenv.py')}, 13:27:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:27:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:27:38 INFO - 'installer_path': 'installer.exe', 13:27:38 INFO - 'log_level': 'info', 13:27:38 INFO - 'log_name': 'talos', 13:27:38 INFO - 'log_to_console': True, 13:27:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:27:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:27:38 INFO - 'opt_config_files': (), 13:27:38 INFO - 'pip_index': False, 13:27:38 INFO - 'sps_profile': False, 13:27:38 INFO - 'sps_profile_interval': 0, 13:27:38 INFO - 'suite': 'dromaeojs-e10s', 13:27:38 INFO - 'system_bits': '32', 13:27:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:27:38 INFO - 'title': 'talos-linux64-ix-023', 13:27:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:27:38 INFO - 'use_talos_json': True, 13:27:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:27:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:27:38 INFO - 'work_dir': 'build'} 13:27:38 INFO - ##### 13:27:38 INFO - ##### Running clobber step. 13:27:38 INFO - ##### 13:27:38 INFO - Running pre-action listener: _resource_record_pre_action 13:27:38 INFO - Running main action method: clobber 13:27:38 INFO - rmtree: /builds/slave/test/build 13:27:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:27:39 INFO - Running post-action listener: _resource_record_post_action 13:27:39 INFO - ##### 13:27:39 INFO - ##### Running read-buildbot-config step. 13:27:39 INFO - ##### 13:27:39 INFO - Running pre-action listener: _resource_record_pre_action 13:27:39 INFO - Running main action method: read_buildbot_config 13:27:39 INFO - Using buildbot properties: 13:27:39 INFO - { 13:27:39 INFO - "project": "", 13:27:39 INFO - "product": "firefox", 13:27:39 INFO - "script_repo_revision": "production", 13:27:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:27:39 INFO - "repository": "", 13:27:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:27:39 INFO - "buildid": "20160506104633", 13:27:39 INFO - "pgo_build": "True", 13:27:39 INFO - "basedir": "/builds/slave/test", 13:27:39 INFO - "buildnumber": 520, 13:27:39 INFO - "slavename": "talos-linux64-ix-023", 13:27:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:27:39 INFO - "platform": "ubuntu64_hw", 13:27:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:27:39 INFO - "branch": "mozilla-inbound", 13:27:39 INFO - "repo_path": "integration/mozilla-inbound", 13:27:39 INFO - "revision": "40745bcb866ff190c40d9a58cb3006a1c58031ba", 13:27:39 INFO - "stage_platform": "linux64-pgo", 13:27:39 INFO - "builduid": "05cc5641ad3947bab3d5732d96f698b4", 13:27:39 INFO - "slavebuilddir": "test" 13:27:39 INFO - } 13:27:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:27:39 INFO - Running post-action listener: _resource_record_post_action 13:27:39 INFO - ##### 13:27:39 INFO - ##### Running download-and-extract step. 13:27:39 INFO - ##### 13:27:39 INFO - Running pre-action listener: _resource_record_pre_action 13:27:39 INFO - Running main action method: download_and_extract 13:27:39 INFO - mkdir: /builds/slave/test/build/tests 13:27: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')]} 13:27:39 INFO - https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:27:39 INFO - Downloaded 1361 bytes. 13:27:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:27:39 INFO - Using the following test package requirements: 13:27:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:27:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:27:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:27:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'jsshell-linux-x86_64.zip'], 13:27:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:27:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:27:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:27:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:27:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:27:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:27:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:27:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:27: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')]} 13:27:39 INFO - https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:27:41 INFO - Downloaded 23882018 bytes. 13:27:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:27:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:27:42 INFO - Return code: 0 13:27:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:27: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')]} 13:27:42 INFO - https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:27:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:27:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:27:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:27:43 INFO - Downloaded 23882018 bytes. 13:27:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:27:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:27:44 INFO - Return code: 0 13:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:44 INFO - https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:27:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:27:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:27:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:27:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:27:45 INFO - Downloaded 10840152 bytes. 13:27:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:27:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:27:45 INFO - Return code: 0 13:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:45 INFO - https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:27:47 INFO - Downloaded 58425445 bytes. 13:27:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:27:47 INFO - mkdir: /builds/slave/test/properties 13:27:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:27:47 INFO - Writing to file /builds/slave/test/properties/build_url 13:27:47 INFO - Contents: 13:27:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:27:48 INFO - Running post-action listener: _resource_record_post_action 13:27:48 INFO - Running post-action listener: set_extra_try_arguments 13:27:48 INFO - ##### 13:27:48 INFO - ##### Running populate-webroot step. 13:27:48 INFO - ##### 13:27:48 INFO - Running pre-action listener: _resource_record_pre_action 13:27:48 INFO - Running main action method: populate_webroot 13:27:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:27:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:27:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:27:48 INFO - '--tppagecycles', 13:27:48 INFO - '7'], 13:27:48 INFO - 'tests': ['tsvgm']}}, 13:27:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:27:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:27:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:27:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:27:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:27:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['damp', 'tps']}, 13:27:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'tests': ['damp', 'tps']}, 13:27:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['dromaeo_dom']}, 13:27:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:27:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['a11yr', 13:27:48 INFO - 'ts_paint', 13:27:48 INFO - 'tpaint', 13:27:48 INFO - 'sessionrestore', 13:27:48 INFO - 'sessionrestore_no_auto_restore', 13:27:48 INFO - 'tabpaint']}, 13:27:48 INFO - 'other-e10s': {'tests': ['a11yr', 13:27:48 INFO - 'ts_paint', 13:27:48 INFO - 'tpaint', 13:27:48 INFO - 'sessionrestore', 13:27:48 INFO - 'sessionrestore_no_auto_restore', 13:27:48 INFO - 'tabpaint']}, 13:27:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:27:48 INFO - 'ts_paint', 13:27:48 INFO - 'tpaint', 13:27:48 INFO - 'sessionrestore', 13:27:48 INFO - 'sessionrestore_no_auto_restore', 13:27:48 INFO - 'tabpaint']}, 13:27:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:27:48 INFO - 'ts_paint', 13:27:48 INFO - 'tpaint', 13:27:48 INFO - 'sessionrestore', 13:27:48 INFO - 'sessionrestore_no_auto_restore', 13:27:48 INFO - 'tabpaint']}, 13:27:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['a11yr', 13:27:48 INFO - 'ts_paint', 13:27:48 INFO - 'tpaint', 13:27:48 INFO - 'sessionrestore', 13:27:48 INFO - 'sessionrestore_no_auto_restore', 13:27:48 INFO - 'tabpaint']}, 13:27:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['a11yr', 13:27:48 INFO - 'ts_paint', 13:27:48 INFO - 'tpaint', 13:27:48 INFO - 'sessionrestore', 13:27:48 INFO - 'sessionrestore_no_auto_restore', 13:27:48 INFO - 'tabpaint']}, 13:27:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['tsvgx', 13:27:48 INFO - 'tsvgr_opacity', 13:27:48 INFO - 'tart', 13:27:48 INFO - 'tscrollx', 13:27:48 INFO - 'cart']}, 13:27:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:27:48 INFO - 'tsvgr_opacity', 13:27:48 INFO - 'tart', 13:27:48 INFO - 'tscrollx', 13:27:48 INFO - 'cart']}, 13:27:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'talos_options': ['--disable-e10s'], 13:27:48 INFO - 'tests': ['tp5o']}, 13:27:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'tests': ['tp5o']}, 13:27:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'talos_options': ['--disable-e10s', 13:27:48 INFO - '--xperf_path', 13:27:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:48 INFO - 'tests': ['tp5n']}, 13:27:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:27:48 INFO - 'talos_options': ['--xperf_path', 13:27:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:27:48 INFO - 'tests': ['tp5n']}}, 13:27:48 INFO - 'talos.zip': {'path': '', 13:27:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:27:48 INFO - Running post-action listener: _resource_record_post_action 13:27:48 INFO - ##### 13:27:48 INFO - ##### Running create-virtualenv step. 13:27:48 INFO - ##### 13:27:48 INFO - Running pre-action listener: _resource_record_pre_action 13:27:48 INFO - Running main action method: create_virtualenv 13:27:48 INFO - Creating virtualenv /builds/slave/test/build/venv 13:27:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:27:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:27:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:27:48 INFO - Using real prefix '/usr' 13:27:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:27:48 INFO - Installing distribute.............................................................................................................................................................................................done. 13:27:50 INFO - Installing pip.................done. 13:27:50 INFO - Return code: 0 13:27:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:27:50 INFO - Using env: {'DISPLAY': ':0', 13:27:50 INFO - 'HOME': '/home/cltbld', 13:27:50 INFO - 'LANG': 'en_US.UTF-8', 13:27:50 INFO - 'LANGUAGE': 'en_US:en', 13:27:50 INFO - 'LOGNAME': 'cltbld', 13:27:50 INFO - 'MAIL': '/var/mail/cltbld', 13:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:50 INFO - 'MOZ_NO_REMOTE': '1', 13:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:50 INFO - 'NO_EM_RESTART': '1', 13:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:50 INFO - 'PWD': '/builds/slave/test', 13:27:50 INFO - 'SHELL': '/bin/bash', 13:27:50 INFO - 'SHLVL': '1', 13:27:50 INFO - 'TERM': 'linux', 13:27:50 INFO - 'TMOUT': '86400', 13:27:50 INFO - 'USER': 'cltbld', 13:27:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:50 INFO - '_': '/tools/buildbot/bin/python'} 13:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:27:50 INFO - Cleaning up... 13:27:50 INFO - Return code: 0 13:27:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:27:50 INFO - Using env: {'DISPLAY': ':0', 13:27:50 INFO - 'HOME': '/home/cltbld', 13:27:50 INFO - 'LANG': 'en_US.UTF-8', 13:27:50 INFO - 'LANGUAGE': 'en_US:en', 13:27:50 INFO - 'LOGNAME': 'cltbld', 13:27:50 INFO - 'MAIL': '/var/mail/cltbld', 13:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:50 INFO - 'MOZ_NO_REMOTE': '1', 13:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:50 INFO - 'NO_EM_RESTART': '1', 13:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:50 INFO - 'PWD': '/builds/slave/test', 13:27:50 INFO - 'SHELL': '/bin/bash', 13:27:50 INFO - 'SHLVL': '1', 13:27:50 INFO - 'TERM': 'linux', 13:27:50 INFO - 'TMOUT': '86400', 13:27:50 INFO - 'USER': 'cltbld', 13:27:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:50 INFO - '_': '/tools/buildbot/bin/python'} 13:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:51 INFO - Downloading/unpacking psutil>=0.7.1 13:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:53 INFO - Installing collected packages: psutil 13:27:53 INFO - Running setup.py install for psutil 13:27:53 INFO - building 'psutil._psutil_linux' extension 13:27:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:27:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:27:53 INFO - building 'psutil._psutil_posix' extension 13:27:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:27:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:53 INFO - Successfully installed psutil 13:27:53 INFO - Cleaning up... 13:27:53 INFO - Return code: 0 13:27:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:27:53 INFO - Using env: {'DISPLAY': ':0', 13:27:53 INFO - 'HOME': '/home/cltbld', 13:27:53 INFO - 'LANG': 'en_US.UTF-8', 13:27:53 INFO - 'LANGUAGE': 'en_US:en', 13:27:53 INFO - 'LOGNAME': 'cltbld', 13:27:53 INFO - 'MAIL': '/var/mail/cltbld', 13:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:53 INFO - 'MOZ_NO_REMOTE': '1', 13:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:53 INFO - 'NO_EM_RESTART': '1', 13:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:53 INFO - 'PWD': '/builds/slave/test', 13:27:53 INFO - 'SHELL': '/bin/bash', 13:27:53 INFO - 'SHLVL': '1', 13:27:53 INFO - 'TERM': 'linux', 13:27:53 INFO - 'TMOUT': '86400', 13:27:53 INFO - 'USER': 'cltbld', 13:27:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:53 INFO - '_': '/tools/buildbot/bin/python'} 13:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:27:55 INFO - Installing collected packages: mozsystemmonitor 13:27:55 INFO - Running setup.py install for mozsystemmonitor 13:27:55 INFO - Successfully installed mozsystemmonitor 13:27:55 INFO - Cleaning up... 13:27:55 INFO - Return code: 0 13:27:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:27:55 INFO - Using env: {'DISPLAY': ':0', 13:27:55 INFO - 'HOME': '/home/cltbld', 13:27:55 INFO - 'LANG': 'en_US.UTF-8', 13:27:55 INFO - 'LANGUAGE': 'en_US:en', 13:27:55 INFO - 'LOGNAME': 'cltbld', 13:27:55 INFO - 'MAIL': '/var/mail/cltbld', 13:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:55 INFO - 'MOZ_NO_REMOTE': '1', 13:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:55 INFO - 'NO_EM_RESTART': '1', 13:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:55 INFO - 'PWD': '/builds/slave/test', 13:27:55 INFO - 'SHELL': '/bin/bash', 13:27:55 INFO - 'SHLVL': '1', 13:27:55 INFO - 'TERM': 'linux', 13:27:55 INFO - 'TMOUT': '86400', 13:27:55 INFO - 'USER': 'cltbld', 13:27:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:55 INFO - '_': '/tools/buildbot/bin/python'} 13:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:27:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:58 INFO - Downloading docopt-0.6.1.tar.gz 13:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:58 INFO - Running setup.py install for blobuploader 13:27:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:27:58 INFO - Running setup.py install for requests 13:27:59 INFO - Running setup.py install for docopt 13:27:59 INFO - Successfully installed blobuploader requests docopt 13:27:59 INFO - Cleaning up... 13:27:59 INFO - Return code: 0 13:27:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:27:59 INFO - Using env: {'DISPLAY': ':0', 13:27:59 INFO - 'HOME': '/home/cltbld', 13:27:59 INFO - 'LANG': 'en_US.UTF-8', 13:27:59 INFO - 'LANGUAGE': 'en_US:en', 13:27:59 INFO - 'LOGNAME': 'cltbld', 13:27:59 INFO - 'MAIL': '/var/mail/cltbld', 13:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:59 INFO - 'MOZ_NO_REMOTE': '1', 13:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:27:59 INFO - 'NO_EM_RESTART': '1', 13:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:59 INFO - 'PWD': '/builds/slave/test', 13:27:59 INFO - 'SHELL': '/bin/bash', 13:27:59 INFO - 'SHLVL': '1', 13:27:59 INFO - 'TERM': 'linux', 13:27:59 INFO - 'TMOUT': '86400', 13:27:59 INFO - 'USER': 'cltbld', 13:27:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:59 INFO - '_': '/tools/buildbot/bin/python'} 13:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:59 INFO - Running setup.py (path:/tmp/pip-BZ5443-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:59 INFO - Running setup.py (path:/tmp/pip-CXzxCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:59 INFO - Running setup.py (path:/tmp/pip-Mg7F8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:59 INFO - Running setup.py (path:/tmp/pip-6JqFgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:59 INFO - Running setup.py (path:/tmp/pip-QgtsYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:59 INFO - Running setup.py (path:/tmp/pip-MsSzoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:59 INFO - Running setup.py (path:/tmp/pip-4Miq0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:28:00 INFO - Running setup.py (path:/tmp/pip-egDafi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:28:00 INFO - Running setup.py (path:/tmp/pip-RHs_vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:28:00 INFO - Running setup.py (path:/tmp/pip-d2Qjb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:28:00 INFO - Running setup.py (path:/tmp/pip-XpXiEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:28:00 INFO - Running setup.py (path:/tmp/pip-A14qJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:28:00 INFO - Running setup.py (path:/tmp/pip-GvwVCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:28:00 INFO - Running setup.py (path:/tmp/pip-Pyk_tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:00 INFO - Running setup.py (path:/tmp/pip-EhAuhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:28:00 INFO - Running setup.py (path:/tmp/pip-ppyRqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:28:00 INFO - Running setup.py (path:/tmp/pip-uBi9C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:28:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:28:00 INFO - Running setup.py install for manifestparser 13:28:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:28:00 INFO - Running setup.py install for mozcrash 13:28:00 INFO - Running setup.py install for mozdebug 13:28:01 INFO - Running setup.py install for mozdevice 13:28:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Running setup.py install for mozfile 13:28:01 INFO - Running setup.py install for mozhttpd 13:28:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Running setup.py install for mozinfo 13:28:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Running setup.py install for mozInstall 13:28:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Running setup.py install for mozleak 13:28:01 INFO - Running setup.py install for mozlog 13:28:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Running setup.py install for moznetwork 13:28:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:28:01 INFO - Running setup.py install for mozprocess 13:28:02 INFO - Running setup.py install for mozprofile 13:28:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:28:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:28:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:28:02 INFO - Running setup.py install for mozrunner 13:28:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:28:02 INFO - Running setup.py install for mozscreenshot 13:28:02 INFO - Running setup.py install for moztest 13:28:02 INFO - Running setup.py install for mozversion 13:28:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:28:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:28:02 INFO - Cleaning up... 13:28:02 INFO - Return code: 0 13:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:28: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')]} 13:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28: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')]} 13:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:28:02 INFO - Using env: {'DISPLAY': ':0', 13:28:02 INFO - 'HOME': '/home/cltbld', 13:28:02 INFO - 'LANG': 'en_US.UTF-8', 13:28:02 INFO - 'LANGUAGE': 'en_US:en', 13:28:02 INFO - 'LOGNAME': 'cltbld', 13:28:02 INFO - 'MAIL': '/var/mail/cltbld', 13:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:02 INFO - 'MOZ_NO_REMOTE': '1', 13:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:02 INFO - 'NO_EM_RESTART': '1', 13:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:02 INFO - 'PWD': '/builds/slave/test', 13:28:02 INFO - 'SHELL': '/bin/bash', 13:28:02 INFO - 'SHLVL': '1', 13:28:02 INFO - 'TERM': 'linux', 13:28:02 INFO - 'TMOUT': '86400', 13:28:02 INFO - 'USER': 'cltbld', 13:28:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:02 INFO - '_': '/tools/buildbot/bin/python'} 13:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:28:02 INFO - Running setup.py (path:/tmp/pip-J2czWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:28:02 INFO - Running setup.py (path:/tmp/pip-hHSDQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:28:02 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)) 13:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:28:02 INFO - Running setup.py (path:/tmp/pip-4rMk8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:28:02 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)) 13:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:28:03 INFO - Running setup.py (path:/tmp/pip-3e1nYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:28:03 INFO - Running setup.py (path:/tmp/pip-gY6yyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:28:03 INFO - Running setup.py (path:/tmp/pip-2L7ePX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:28:03 INFO - Running setup.py (path:/tmp/pip-edY4lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:28:03 INFO - Running setup.py (path:/tmp/pip-_2pSej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:28:03 INFO - Running setup.py (path:/tmp/pip-F5Dw2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:28:03 INFO - Running setup.py (path:/tmp/pip-1zjK0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:28:03 INFO - Running setup.py (path:/tmp/pip-yGBHqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:28:03 INFO - Running setup.py (path:/tmp/pip-Vw7Gkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:28:03 INFO - Running setup.py (path:/tmp/pip-OHTNDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:28:03 INFO - Running setup.py (path:/tmp/pip-YogJ_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:03 INFO - Running setup.py (path:/tmp/pip-EdNnoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:28:03 INFO - Running setup.py (path:/tmp/pip-bcevir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:28:03 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)) 13:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:28:03 INFO - Running setup.py (path:/tmp/pip-Dm72tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:28:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:05 INFO - Downloading blessings-1.6.tar.gz 13:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:28:05 INFO - Installing collected packages: blessings 13:28:05 INFO - Running setup.py install for blessings 13:28:06 INFO - Successfully installed blessings 13:28:06 INFO - Cleaning up... 13:28:06 INFO - Return code: 0 13:28:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:28:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:28:06 INFO - Reading from file tmpfile_stdout 13:28:06 INFO - Current package versions: 13:28:06 INFO - argparse == 1.2.1 13:28:06 INFO - blessings == 1.6 13:28:06 INFO - blobuploader == 1.2.4 13:28:06 INFO - docopt == 0.6.1 13:28:06 INFO - manifestparser == 1.1 13:28:06 INFO - mozInstall == 1.12 13:28:06 INFO - mozcrash == 0.17 13:28:06 INFO - mozdebug == 0.1 13:28:06 INFO - mozdevice == 0.48 13:28:06 INFO - mozfile == 1.2 13:28:06 INFO - mozhttpd == 0.7 13:28:06 INFO - mozinfo == 0.9 13:28:06 INFO - mozleak == 0.1 13:28:06 INFO - mozlog == 3.1 13:28:06 INFO - moznetwork == 0.27 13:28:06 INFO - mozprocess == 0.22 13:28:06 INFO - mozprofile == 0.28 13:28:06 INFO - mozrunner == 6.11 13:28:06 INFO - mozscreenshot == 0.1 13:28:06 INFO - mozsystemmonitor == 0.0 13:28:06 INFO - moztest == 0.7 13:28:06 INFO - mozversion == 1.4 13:28:06 INFO - psutil == 3.1.1 13:28:06 INFO - requests == 1.2.3 13:28:06 INFO - wsgiref == 0.1.2 13:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:28:06 INFO - Using env: {'DISPLAY': ':0', 13:28:06 INFO - 'HOME': '/home/cltbld', 13:28:06 INFO - 'LANG': 'en_US.UTF-8', 13:28:06 INFO - 'LANGUAGE': 'en_US:en', 13:28:06 INFO - 'LOGNAME': 'cltbld', 13:28:06 INFO - 'MAIL': '/var/mail/cltbld', 13:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:06 INFO - 'MOZ_NO_REMOTE': '1', 13:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:06 INFO - 'NO_EM_RESTART': '1', 13:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:06 INFO - 'PWD': '/builds/slave/test', 13:28:06 INFO - 'SHELL': '/bin/bash', 13:28:06 INFO - 'SHLVL': '1', 13:28:06 INFO - 'TERM': 'linux', 13:28:06 INFO - 'TMOUT': '86400', 13:28:06 INFO - 'USER': 'cltbld', 13:28:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:06 INFO - '_': '/tools/buildbot/bin/python'} 13:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:28:06 INFO - Cleaning up... 13:28:06 INFO - Return code: 0 13:28:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:28:06 INFO - Using env: {'DISPLAY': ':0', 13:28:06 INFO - 'HOME': '/home/cltbld', 13:28:06 INFO - 'LANG': 'en_US.UTF-8', 13:28:06 INFO - 'LANGUAGE': 'en_US:en', 13:28:06 INFO - 'LOGNAME': 'cltbld', 13:28:06 INFO - 'MAIL': '/var/mail/cltbld', 13:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:06 INFO - 'MOZ_NO_REMOTE': '1', 13:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:06 INFO - 'NO_EM_RESTART': '1', 13:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:06 INFO - 'PWD': '/builds/slave/test', 13:28:06 INFO - 'SHELL': '/bin/bash', 13:28:06 INFO - 'SHLVL': '1', 13:28:06 INFO - 'TERM': 'linux', 13:28:06 INFO - 'TMOUT': '86400', 13:28:06 INFO - 'USER': 'cltbld', 13:28:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:06 INFO - '_': '/tools/buildbot/bin/python'} 13:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:06 INFO - Downloading/unpacking jsonschema 13:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:28:08 INFO - Downloading/unpacking functools32 (from jsonschema) 13:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:28:08 INFO - warning: no files found matching '*.txt' 13:28:08 INFO - no previously-included directories found matching 'build' 13:28:08 INFO - no previously-included directories found matching 'dist' 13:28:08 INFO - no previously-included directories found matching '.git*' 13:28:08 INFO - Installing collected packages: jsonschema, functools32 13:28:09 INFO - Running setup.py install for functools32 13:28:09 INFO - warning: no files found matching '*.txt' 13:28:09 INFO - no previously-included directories found matching 'build' 13:28:09 INFO - no previously-included directories found matching 'dist' 13:28:09 INFO - no previously-included directories found matching '.git*' 13:28:09 INFO - Successfully installed jsonschema functools32 13:28:09 INFO - Cleaning up... 13:28:09 INFO - Return code: 0 13:28:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f415245cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', '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 13:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:28:09 INFO - Using env: {'DISPLAY': ':0', 13:28:09 INFO - 'HOME': '/home/cltbld', 13:28:09 INFO - 'LANG': 'en_US.UTF-8', 13:28:09 INFO - 'LANGUAGE': 'en_US:en', 13:28:09 INFO - 'LOGNAME': 'cltbld', 13:28:09 INFO - 'MAIL': '/var/mail/cltbld', 13:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:09 INFO - 'MOZ_NO_REMOTE': '1', 13:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:09 INFO - 'NO_EM_RESTART': '1', 13:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:09 INFO - 'PWD': '/builds/slave/test', 13:28:09 INFO - 'SHELL': '/bin/bash', 13:28:09 INFO - 'SHLVL': '1', 13:28:09 INFO - 'TERM': 'linux', 13:28:09 INFO - 'TMOUT': '86400', 13:28:09 INFO - 'USER': 'cltbld', 13:28:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:09 INFO - '_': '/tools/buildbot/bin/python'} 13:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:28:09 INFO - Downloading/unpacking flake8 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:28:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:28:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:28:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:28:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:28:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:28:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:28:11 INFO - no previously-included directories found matching 'docs/_build' 13:28:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:28:12 INFO - Running setup.py install for pep8 13:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:28:12 INFO - no previously-included directories found matching 'docs/_build' 13:28:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:28:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:28:12 INFO - Cleaning up... 13:28:12 INFO - Return code: 0 13:28:12 INFO - Running post-action listener: _resource_record_post_action 13:28:12 INFO - Running post-action listener: _start_resource_monitoring 13:28:12 INFO - Starting resource monitoring. 13:28:12 INFO - ##### 13:28:12 INFO - ##### Running install step. 13:28:12 INFO - ##### 13:28:12 INFO - Running pre-action listener: _resource_record_pre_action 13:28:12 INFO - Running main action method: install 13:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:28:12 INFO - Reading from file tmpfile_stdout 13:28:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:28:12 INFO - Reading from file tmpfile_stdout 13:28:12 INFO - Output received: 13:28:12 INFO - Usage: mozinstall [options] installer 13:28:12 INFO - Options: 13:28:12 INFO - -h, --help show this help message and exit 13:28:12 INFO - -d DEST, --destination=DEST 13:28:12 INFO - Directory to install application into. [default: 13:28:12 INFO - "/builds/slave/test"] 13:28:12 INFO - --app=APP Application being installed. [default: firefox] 13:28:12 INFO - mkdir: /builds/slave/test/build/application 13:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:28:29 INFO - Reading from file tmpfile_stdout 13:28:29 INFO - Output received: 13:28:29 INFO - /builds/slave/test/build/application/firefox/firefox 13:28:29 INFO - Running post-action listener: _resource_record_post_action 13:28:29 INFO - ##### 13:28:29 INFO - ##### Running run-tests step. 13:28:29 INFO - ##### 13:28:29 INFO - Running pre-action listener: _resource_record_pre_action 13:28:29 INFO - Running main action method: run_tests 13:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:28:29 INFO - Python 2.7.3 13:28:29 INFO - Return code: 0 13:28:29 INFO - grabbing minidump binary from tooltool 13:28: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')]} 13:28:29 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 0x1eab410>, '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 0x1eac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eac7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:28:29 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 13:28:29 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 13:28:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:28:29 INFO - Return code: 0 13:28:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:28:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:28:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:28:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:28:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:28:30 INFO - Return code: 0 13:28:30 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/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:28:30 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/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 13:28:30 INFO - Using env: {'DISPLAY': ':0', 13:28:30 INFO - 'HOME': '/home/cltbld', 13:28:30 INFO - 'LANG': 'en_US.UTF-8', 13:28:30 INFO - 'LANGUAGE': 'en_US:en', 13:28:30 INFO - 'LOGNAME': 'cltbld', 13:28:30 INFO - 'MAIL': '/var/mail/cltbld', 13:28:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:28:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:28:30 INFO - 'MOZ_NO_REMOTE': '1', 13:28:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:28:30 INFO - 'NO_EM_RESTART': '1', 13:28:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:28:30 INFO - 'PWD': '/builds/slave/test', 13:28:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:28:30 INFO - 'SHELL': '/bin/bash', 13:28:30 INFO - 'SHLVL': '1', 13:28:30 INFO - 'TERM': 'linux', 13:28:30 INFO - 'TMOUT': '86400', 13:28:30 INFO - 'USER': 'cltbld', 13:28:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370', 13:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:28:30 INFO - '_': '/tools/buildbot/bin/python'} 13:28:30 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/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:28:30 INFO - mozversion application_buildid: 20160506104633 13:28:30 INFO - mozversion application_changeset: 40745bcb866ff190c40d9a58cb3006a1c58031ba 13:28:30 INFO - mozversion application_display_name: Nightly 13:28:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:28:30 INFO - mozversion application_name: Firefox 13:28:30 INFO - mozversion application_remotingname: firefox 13:28:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:28:30 INFO - mozversion application_vendor: Mozilla 13:28:30 INFO - mozversion application_version: 49.0a1 13:28:30 INFO - mozversion platform_buildid: 20160506104633 13:28:30 INFO - mozversion platform_changeset: 40745bcb866ff190c40d9a58cb3006a1c58031ba 13:28:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:28:30 INFO - mozversion platform_version: 49.0a1 13:28:30 INFO - using testdate: 1462566510 13:28:30 INFO - actual date: 1462566510 13:28:30 INFO - starting webserver on 'localhost:46114' 13:28:30 INFO - SUITE-START | Running 2 tests 13:28:30 INFO - TEST-START | dromaeo_css 13:28:30 INFO - operating with platform_type : linux_ 13:28:30 INFO - Initialising browser for dromaeo_css test... 13:28:30 INFO - TEST-INFO | started process 19600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HeE0Q/profile http://localhost:46114/getInfo.html) 13:28:34 INFO - PROCESS | 19600 | 13:28:34 INFO - PROCESS | 19600 | (process:19668): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:28:34 INFO - PROCESS | 19600 | __metrics Screen width/height:1600/1200 13:28:34 INFO - PROCESS | 19600 | colorDepth:24 13:28:34 INFO - PROCESS | 19600 | Browser inner width/height: 1024/697 13:28:34 INFO - PROCESS | 19600 | __metrics 13:28:35 ERROR - PROCESS | 19600 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:28:36 INFO - TEST-INFO | 19600: exit 0 13:28:36 INFO - Browser initialized. 13:28:36 INFO - Running cycle 1/1 for dromaeo_css test... 13:28:36 INFO - TEST-INFO | started process 19719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1HeE0Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:28:37 INFO - PROCESS | 19719 | 13:28:37 INFO - PROCESS | 19719 | (process:19780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:28:47 INFO - PROCESS | 19719 | RSS: Main: 165212160 13:28:47 INFO - PROCESS | 19719 | 13:29:37 INFO - PROCESS | 19719 | 1462566577513 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] 13:31:45 INFO - PROCESS | 19719 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46114/tests/dromaeo/cssquery-ext.html) 13:31:46 INFO - PROCESS | 19719 | RSS: Main: 170635264 13:31:46 INFO - PROCESS | 19719 | 13:34:48 INFO - PROCESS | 19719 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-ext.html (next: http://localhost:46114/tests/dromaeo/cssquery-jquery.html) 13:34:49 INFO - PROCESS | 19719 | RSS: Main: 167206912 13:34:49 INFO - PROCESS | 19719 | 13:37:51 INFO - PROCESS | 19719 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46114/tests/dromaeo/cssquery-mootools.html) 13:37:52 INFO - PROCESS | 19719 | RSS: Main: 168177664 13:37:52 INFO - PROCESS | 19719 | 13:40:53 INFO - PROCESS | 19719 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46114/tests/dromaeo/cssquery-prototype.html) 13:40:54 INFO - PROCESS | 19719 | RSS: Main: 165879808 13:40:54 INFO - PROCESS | 19719 | 13:43:57 INFO - PROCESS | 19719 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46114/tests/dromaeo/cssquery-yui.html) 13:43:57 INFO - PROCESS | 19719 | RSS: Main: 167911424 13:43:57 INFO - PROCESS | 19719 | 13:46:59 INFO - PROCESS | 19719 | Cycle 1(1): loaded http://localhost:46114/tests/dromaeo/cssquery-yui.html (next: http://localhost:46114/tests/dromaeo/cssquery-dojo.html) 13:47:00 INFO - PROCESS | 19719 | RSS: Main: 169287680 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | __start_tp_report 13:47:00 INFO - PROCESS | 19719 | _x_x_mozilla_page_load 13:47:00 INFO - PROCESS | 19719 | _x_x_mozilla_page_load_details 13:47:00 INFO - PROCESS | 19719 | |i|pagename|runs| 13:47:00 INFO - PROCESS | 19719 | |0;dojo.html;3206.374756922401;3246.8214248216345;3247.464168412212;3258.5763850699404;3264.689854463825;5582.6929518876495;5620.325560932689;5631.5213206877415;5645.661260324373;5682.573806964484;5435.945640543593;5531.115021596545;5574.60977731559;5586.13414920687;5587.357453892803;5008.7245201514;5036.546710796028;5095.643304968654;5187.636865419422;5195.038917800201;5110.233464980245;5214.661047031931;5234.921476177841;5243.764030618631;5260.105782017047;4873.902521949559;4947.678400903929;4989.825356112555;5119.820806271781;5126;5036.244563315496;5048.9495105048845;5053.620978426633;5053.646244762868;5087.516685914832;4993.076280888047;5006.824761133343;5009.398872135331;5015.122353588144;5045.344105266292;5348.946510534884;5383.2194331821665;5414.29614150158;5449.5640348772;5499.890002199933;5979.282486101695;5994.190784244115;5996.97001514994;6000.33996260411;6001.819945401601;6048.758049678007;6048.818535443944;6050.546209034296;6052.878942421171;6056.242969628796;5364.91952620711;5526.171074338841;5530.419305972895;5548.167774833726;5625.268715067097;6111.266648002268;6121.265448146251;6151.415615516519;6151.96924015377;6152.384761523812;5673.914891276634;5897;5912.201852749909;5921.052631579013;5921.851953701192;5965.463108320272;6045.758169673164;6047.425494578008;6113.266408031065;6119;5708.143778433268;5909.527237820964;5928.318243401977;6005.879882402415;6078.179445774852;5768.278965129359;5952.345242023374;6024.126501657235;6036.2756469223095;6069.908951365733;4456.844010459618;4472.08322293929;4499.167653984024;4505.279155335196;4510.255807791677;3988.441618173458;3998.04047028711;4011.338129208648;4033.3748269018347;4044.595540445932;5520.585956053312;5635.718214089279;5707;5721.027425337703;5747.166660834156;5954.612950158313;6023.427774361428;6049.727762250709;6056.848578785478;6063;5686.658800471985;5702.714864256771;5719.828405147852;5745.798897038583;5763.077907534858;4951.356323677899;5046.293518907356;5075.644704870698;5137;5161.896762064737;6126.111713801563;6159.260888693296;6167.444929956326;6168.321484636686;6177.598456100339;5917.940820591911;5946.672932988728;5952.642841429528;5971.4327138921735;5977.820665380045;5936.703164841827;5996.970015149896;6096.573239873166;6098.207233059674;6149.354317796567;5817.243758311392;5871.119332100048;5884.323302820059;5888;5916.615419997686;5929.318128415288;5972.910406343822;5980.102984552352;5984.31180414258;5996.400359963969;5632.324121105494;5704.657720536781;5822.563307752021;5864.266966629171;5872.823815285548;5774.133879918046;5810.912836307374;5819.0689489681445;5866.853328666817;5869.354371019099;5742.885142297214;5758.366579676149;5778.85552861165;5793.15999180125;5796.507296879644;5666.829995100154;5837.153612726216;5894;5899.439553242435;5925.555583331354;5736.397678243724;5749.108888122348;5763.250777398911;5782.1615865698395;5799.159121927212 13:47:00 INFO - PROCESS | 19719 | |1;ext.html;598.0192484325704;633.5565104426901;639.3989649729255;651.8044586624012;651.9608823470592;37913.24173516528;41000.384994225074;41105.17789644205;41131.326463779835;41136;40241.59758402415;41136.794316028376;41303.58696413035;41362.17275654485;41412;8513.106123856998;8732.694355697551;8778.341624378165;8781;8805.515696636683;8341.499510029387;8374.078851326349;8420.326373890104;8444.57777111142;8450.323974082059;8434.62044208009;8449.32405407569;8503.65985360588;8519.53142577158;8523.872141917876;8363.20549547792;8374.83250334993;8395.916040839575;8415.999999999969;8474.491530508189;8705.216530512283;8766.605502752327;8776.034636190014;8776.868346974801;8784.51685157316;38314.61685383139;38784;38838.611613884066;38918;39195;3822.9044273893096;3843.1929294848114;4108.50697916249;4163.500379954425;4322.82708691652;31098.689013110034;31104.222394440094;31322.21694457634;31350.52974205389;32421.83789081063;4413.735175889425;4499.887502812423;4593.150267200579;4605.332226827091;4618.191816432144;299332;299918.0049197055;300718;301985;302440.3413778119;34793.13017174591;35332.64667353345;35904;53939.730301348245;54600.72699636476;36847;36867;36905.81547092248;37054.258914821556;37151.81424092862;14280.642983925278;14322.212278324583;14334.21161836109;14342.856571434151;14367.78448323276;12295.877041229473;12438.626841194779;12471.875281247252;12479.75040499185;12494.875051249372;8454.492730436194;8540.70107546233;8570.48577085377;8589.871151932726;8595.570221489026;3348.464245720673;3356.429407000767;3369.646187150363;3374.1395944034116;3376.324735052999;1069.2301542889106;1088.4231357380602;1103.6799328194895;1156.8669602995594;1182.5565412970136;32059.35881282361;32384.676153238164;32596.511052334234;32733.836330818194;33490.665093348754;1090.6455401994224;1151.6775302915198;1188.2632767683917;1204.4158583087196;1217.1662411248324;15931.522054338388;16198.838011619733;16224.188790560425;16305.755413668805;16326.836731632531;467185;469783;470291;471128;471214;54398.45601544013;54961.725191373785;55198.724006379714;55213.17180242299;55333;1430.399232322427;1434.583970648521;1440.4310297432455;1440.7910852926268;1461.218248237188;29548.852255738584;29754.70245297606;30017.849910750305;30121.246968825955;30479.695203048574;46810;47684.5231547694;47685.52314476811;47705.522944770106;47774.76112619415;419656;420116;422101;424720;425394;26861.731382685924;27544.934129939935;27608.585871212348;27693.169204923885;27694.584581231702;45956;48991;51627;53840;54843.725781370835;40763.184736304516;41962.37056444217;42359.576404235566;42632.360514592925;43263.35104973365;41281.380779287734;41664;41915.79042104892;42280.365794512494;42799.14401711886;36937.63062369342;41529.37705934353;41778;42083.36874946817;42988.570114298454;34806;35299.470507941885;35716.82141589275;36597.268054638225;37114.44328335023;28114.156575302775;28883.422331552832;29105.708942911147;29231.415371692023;29472.41055178927 13:47:00 INFO - PROCESS | 19719 | |2;jquery.html;376.5199370802227;382.969362451004;383.313868175965;398.43621275894577;402.39640539191214;15407.152606606633;17109.657806843854;18134.63730725388;20298.492537686547;20388.592228155445;17956.820431795677;19176.616467670672;19374.903125484387;19898.70151947722;19942.102605382755;5564.944350556483;5603.476230624551;5747.281589801275;5775.1337299405;5778.508826749731;5322;5604.159376093598;5611.3266408031095;5690.317161940573;5722.256106706143;5300.761465734032;5607.7476513556785;5680.971595142039;5683.062294721366;5694.829155125353;5607.186957891124;5648.604597678164;5682.772689092472;5685.715714214293;5751.884962300752;5696.857578560528;5710.200571919934;5715.057015592422;5721.027425337703;5728.770849166029;12035.27788332694;12100.939495302555;12708;13761.655958601015;13965.3715582798;2252.650839119939;2288.8168946484243;2294.2314324701247;2342.203650758733;2379.131616959797;10208.948955255251;10365.17078633715;10386.948065259701;10440.37357758537;10587.78824423515;1924.980750192494;1942.3784388995527;1943.620993906189;2067.514134178467;2069.927552535654;71928.64035679841;75541;84857.15142848616;85009.57495212546;87679;10118.949405252926;10206.336588121749;10310.278280520291;10341.276110672181;10684.839727404094;11542.365169915734;12135.15053946233;12166.695832604255;14149.151050936976;14286.499972500913;6098.969505152446;6317.5893566918;6777.762778302736;7219.602921839244;7335.853282934311;7077.610731409822;7123.89314160288;7194.064771579766;7231.927680723125;7258.165310989199;3744.812759362021;3791.658750712449;3871.5160604924386;3907.257621051991;3948.6446219840354;1875.7749070111674;1877.4461533847548;1881.4543782303253;1885.849132069431;1938.5347516595916;1026.2662196529518;1034.8706411698538;1082.3451811653836;1112.3548341961643;1175.2713317743055;19181.232750690095;19510.70733938992;19588.90205548963;19606.215751369786;19661.311854085037;1061.7611037516497;1061.877884043345;1068.71144790906;1070.7751372211767;1080.3841810168285;10682.732931676615;11125.499352529156;11135.777284454265;11145.665630031112;11146.275492092987;463934;474174;476978;478595;481266;95639.52180239193;97164.51417743007;98044;98415.50792245993;98480;1051.033049594375;1063.1813503602184;1065.5098654618962;1086.7446150154708;1108.7394462301352;17063.91468042652;17118;17156.15725898536;17207.913960430116;17580.648387032445;39786.80106599564;40869.1826163481;41328.58671413247;41347;41474.585254147074;55593.72203138958;57109.714451429136;57167.71416142893;57457.71271143617;57803.71098144483;8550.78623034429;8651.351148663749;8884.466931984101;9017.954910225408;9018.86471702938;12748.936255318664;13315.201087934754;13525.797113043509;13536.729265414833;13883.444662213802;11964.222325548812;12096.697582560506;12114.091443141975;12133.09001824849;12217.083718720954;11548.191626586058;11910.404479775803;12049.68882398802;12101.939490302491;12170.45232964501;9503.57446383048;12024.939875300568;12234.938825305817;12336.074794390635;12495.437705303464;7051.330123638246;7887.329576986021;8120.431569790058;8569.228769410784;8999.595018224065;10891;12391.132620716464;12401;12640.051996100514;12725.109242353317 13:47:00 INFO - PROCESS | 19719 | |3;mootools.html;1463.9048461849975;1511.4936496273747;1648.2665213979776;1661.941832035879;1770.6989811731996;7722.304992550669;8324.542150181738;8407.117252688457;8898.555072246387;8900.91099089009;8410;8643.611037503311;8657;8705.912940870588;8776.517291548962;2311.075569772092;2322.2336628912503;2327.8719670418122;2332.7317358503733;2348.1311914591624;2274.2949685597437;2275.203678712454;2293.8738369389675;2320.5590937721863;2325.465143017107;2306.423394151462;2314.2247347138727;2323.500447403808;2362.3267368799898;2385.129427758864;2245.9663105053437;2273.102124660766;2280.8859557022247;2289.095807156181;2301.2866011536476;2348.2016114521143;2348.2368230325214;2374.169040835711;2374.893129809163;2377.5601513720017;8683.696070637498;8775.692850750256;8779.517126558037;8790.604422800989;8802.64789408423;5222.92165617516;5339.839804805862;5355.196720491918;5373.650712703662;5375.892482150335;3306.6528014558367;3352.122362932276;3424.8630054797777;3460.7058400036026;3488.4069708149677;1115.252780636975;1156.7512984708244;1163.4880652512952;1166.3177041430772;1180.0559552358166;12089.335086570236;12105;12156.331401772988;12161.635150945398;12193.45129469176;4419.558044195554;4733.786979585927;4741.075490279362;4746.382970213919;4775.116603428377;10290.639827606148;10358.430286334173;10368.844467332996;10370.792584148276;10417.5832966682;5152.355955505562;5342.198670199501;5362.678239305576;5372.570194384518;5405.243265942771;4167.791610419466;4679.64902632304;4712.740799256074;4753.5959443447;4903.656744027884;4015.91968160641;4046;4080.0615858352744;4083.612056854594;4143.295639741251;1247.8502579690496;1291.5156816193928;1299.330844615024;1304.8368953880765;1324.9536266230637;950.5579905344048;1020.6274709730894;1038.6832016234969;1057.1489950589848;1081.6106201767357;6108.969455152785;6245.594036387711;6278.434940855345;6293.339199383999;6412.35876412355;424.37404827878635;428.70847823480335;429.364540480085;432.9437173167468;437.1911962868667;4291.721038132511;4355.237833379146;4359.716618419792;4388.4953230378915;4411.228035093845;10453.68638940833;10756.354618722902;10886.61896833607;10908.34549927007;10981.3960232188;10197.694069177936;10771.6229931952;10789.29869558492;10867.728306792393;10914.508847101899;8084.83830323402;8224.958875205706;8264.752057438287;8299.377546684023;8325;6110.297315808739;6253.656048917172;6316.399942005502;6354.205724284465;6368.395002474757;9985.900140998498;10110.09009189147;10126.696199114038;10138.493075346056;10213.387196768217;10022.899771002489;10164.136048435967;10240.027197416233;10256.43589602579;10266.178705703376;7102.431805455654;7366.042414486083;7556.395488360808;7929.127795942326;8022.358211343195;8294.336453083619;8320.750377488685;8361.95819020901;8399.370047246603;8407.411481196257;7351.154617219088;7631.465797394129;7670.539767613961;7691.846163076819;7716.382689384948;7166.355028047292;7213.783586492414;7348.96325518369;7396.297351751575;7577.5453472791805;7010.334018268461;7047.577145371294;7056.223815380406;7056.259092795182;7111.751088711871;5135.640505164752;5205.141151709925;5267.920981185209;5284.101702710472;5313.946860531345;5414.10667239901;5429.104197807475;5433.429489903661;5434.1033729435785;5447.836564903059 13:47:00 INFO - PROCESS | 19719 | |4;prototype.html;336.5574269835167;338.80688007835545;345.90833429141276;347.4544964405884;348.8988193423909;5645.604807663465;5647.632903861246;5653.1520271959225;5668.178114173443;5701.828945131648;5579.69311687858;5584.5253153482;5590.18942253373;5600.4959553640165;5602.60781745277;4113.280175969208;4231.386448964899;4316.935245971313;4334.913301733964;4361.5856493633055;4347.869563913072;4349.717268377545;4351.108022855323;4368.650507959372;4368.907773056736;4354.847580334689;4355.346697995295;4364.406991448114;4377.277749171399;4381.912361752763;4266.189424009443;4268.338407546819;4316.417283666696;4322.891927701801;4332.826686932519;3812.275667623143;3824.3937546230372;3830.9808450957566;3840.116773142193;3855.7879316637573;5342.893142137174;5365.651232669864;5402.837914862521;5404.270423492818;5405.891882162335;4924.409070911478;4980.306695723435;4991.276264941599;4992.40091189056;4996.700197988096;5802.578368299752;5810.448007439329;5820.272465941757;5860.120981852713;5862.443067908542;4227.450431443893;4252.617264446215;4259.5740425957465;4264.893377665552;4296.63478604319;5801.506871915893;6085.752420753734;6095.725692343811;6101.125785126433;6200.968995155041;4156.7921603919685;4174.91650167001;4199.853005144805;4210.052738133895;4213.377849527954;4266.360045993126;4277.2087163874785;4279.700420970502;4280.272353699816;4288.871333859989;4788.976055119702;4918.90162196754;4926.359573255454;4953;4955.653104282737;5778.3354914184565;5887.263257339096;5889.263842019747;5920.2895652521975;5963.642181469126;1431;1431.2485944879022;1437.173625165534;1458.1688437590683;1458.4749490183526;947.1144479911168;961.5961296255589;961.8172547216006;962.8748262725801;964.8697425847421;5513.862153446196;5526.45259327389;5558.527525160407;5560.277163968658;5564.914841605848;5876.794312199053;5892.941070589325;5893.322267939242;5924.437178468039;5934.13954976526;5381.811636592701;5547.446714919829;5763.510101641324;5767.22142510764;5770.6249093808765;3127.2338277121794;3189.2345836999416;3194.536792165123;3201.7193122751087;3201.8719251230154;6115.534389959553;6132.018876979661;6213.285472170758;6230.813075607739;6279;6086.239220097488;6095.969520152459;6099.481544068715;6185.226846644169;6196.845078873064;6110.938890611126;6115.327313995457;6195.721192546346;6214.844628884314;6238.469730072904;5699.116636921284;6055.848603784941;6110.297315808739;6201.131841542097;6205.720742566505;6011.428914253313;6058.969705151446;6076.4201307661215;6077.453029227391;6100.847478813065;6151.846203844761;6295.433410993032;6312.621242725451;6316.873662526816;6346.079818426395;4253.8723838284905;4274.5939135782055;4278.336857787048;4281.529031806561;4293.355996600535;5815.563832712648;5931.555133364928;6137.447629713169;6168.722407491763;6177.84555386119;5859.882802344015;5866.682660349224;5866.794662186803;5893.705314734332;5921.585489015728;5810.94189058104;5900.232969713909;5904.3210030847;5919.526437884872;5919.7864437789285;5571.609987301013;5773.278340207474;5804.419558044162;5809.186713859978;5830.2889156542415;5882.7352119294555;5904.61619994699;5915.733791979457;5945.34601193877;5964.880702385841;5650.152477128299;5789.507891829242;5794.420557944172;5798.985177593989;5857.602590497416 13:47:00 INFO - PROCESS | 19719 | |5;yui.html;822.8806823010664;844.9873251901223;847.2163248994678;871.7341210930664;875.3434923807145;14560.56318310451;14660;14667;14737.70524589509;14855.925720371397;13975.79036314456;13987.65030874226;13988.440462381492;13992.440302387919;13995.580132596013;670.1121014655589;798.9480683755537;820.9055958564782;823.6952327638782;825.2737590919982;805.8468890910708;814.5357146426539;815;816.6284340625001;818.54161669465;870.5299138465222;873.2795443758893;874.5452364770316;877.4121338703052;878.3939082033377;862.4437237981498;863.4258218284833;866.4108406283724;867.4535042922918;867.5185272173941;634.0109429290276;637.5314144104079;637.5600835423589;638.294684373765;640.2445114764575;14113.78829317561;14123.223222722747;14130;14137.85862141386;14166;14086.506972255922;14112.294385280695;14213;14328.355224014944;14562;11423.600173993871;11463.31220126795;11580.536778528849;11721.824172637333;11823.940880295544;3860.7297489175767;3908.687305015592;3914.099757055893;3966.6231707987695;4092.1815636872743;52696;53899.73050134724;56124.15813762838;56363.71818140924;56505.43494565043;11206.775864482664;11229.606963756392;11239.157063220291;11301.378424186585;11333.43332833355;20420.693689594667;20569.48576285605;20586.58826823455;20621.865797381288;20636.79363206379;8059.677612895536;8225.218604232588;8557.144285571392;8746.650133994695;8791.252743516745;4596;4656.371389862393;4671.27595222741;4688.671792974527;4738.691985020962;3213.501907204387;3363.882264120744;3364.2094107884627;3371.359441706068;3388.5764279465066;609.2688773471851;621.8725161341914;626.2891618013588;627.5450298533618;634.1154090044362;622.1290193728726;642.2998931165052;720.7585458871232;735.3381956239427;758.4311766175368;8531.317494600416;8932.436823555852;9065;9101.954490227507;9176.44941303524;676.8646270745772;706.7490541741089;728.2571776787753;734.3941248470034;744.757953665061;4196.531214075049;4231.217224813419;4242.321228603409;4301.2257793597455;4368.628666563378;62341.064884026775;62495;62727.059094113625;64266.357336426976;64304;27777.722222777917;27998.3000424991;49934;50447.49552504428;57360;51365.22952155721;52247.73876130671;52720;53241;55043;9535.713928582154;9568.378055426376;9817.410955342702;9848;9911;31905.8404707975;32807.67192328046;32864.1783955403;33194.170145746546;34360.312793743484;43421;44252;44307.11385772331;44516.777416114004;45224;11555.942220288845;11645.708857278636;11656.417179140839;12013.699657508632;12918.932970725014;13529.458821647024;13535;13820.861791381958;14120.717585648024;14338.283085845875;13091.67270818199;13156.407961641558;13157.144785588906;13172.209667419986;13198.274094924871;12604.495820167458;12621.558245461365;12851.807222891852;13145;13231.867681323063;12992.155509891827;13084.542041028519;13120.081594288307;13369.131006484547;13563.660908477366;10841.891581084405;10894.67315980522;11003.61487347939;11182.832257516306;11537.884621154017;10813.51339189754;11168.162387820783;11236.719082023015;11260.774784504429;11372.374519401512 13:47:00 INFO - PROCESS | 19719 | __end_tp_report 13:47:00 INFO - PROCESS | 19719 | __start_cc_report 13:47:00 INFO - PROCESS | 19719 | _x_x_mozilla_cycle_collect,346 13:47:00 INFO - PROCESS | 19719 | __end_cc_report 13:47:00 INFO - PROCESS | 19719 | __startTimestamp1462567620192__endTimestamp 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | ------- Summary: start ------- 13:47:00 INFO - PROCESS | 19719 | Number of tests: 6 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | [#0] dojo.html Cycles:165 Average:5538.39 Median:5758.37 stddev:639.76 (11.1%) stddev-sans-first:615.01 13:47:00 INFO - PROCESS | 19719 | Values: 3206.4 3246.8 3247.5 3258.6 3264.7 5582.7 5620.3 5631.5 5645.7 5682.6 5435.9 5531.1 5574.6 5586.1 5587.4 5008.7 5036.5 5095.6 5187.6 5195.0 5110.2 5214.7 5234.9 5243.8 5260.1 4873.9 4947.7 4989.8 5119.8 5126.0 5036.2 5048.9 5053.6 5053.6 5087.5 4993.1 5006.8 5009.4 5015.1 5045.3 5348.9 5383.2 5414.3 5449.6 5499.9 5979.3 5994.2 5997.0 6000.3 6001.8 6048.8 6048.8 6050.5 6052.9 6056.2 5364.9 5526.2 5530.4 5548.2 5625.3 6111.3 6121.3 6151.4 6152.0 6152.4 5673.9 5897.0 5912.2 5921.1 5921.9 5965.5 6045.8 6047.4 6113.3 6119.0 5708.1 5909.5 5928.3 6005.9 6078.2 5768.3 5952.3 6024.1 6036.3 6069.9 4456.8 4472.1 4499.2 4505.3 4510.3 3988.4 3998.0 4011.3 4033.4 4044.6 5520.6 5635.7 5707.0 5721.0 5747.2 5954.6 6023.4 6049.7 6056.8 6063.0 5686.7 5702.7 5719.8 5745.8 5763.1 4951.4 5046.3 5075.6 5137.0 5161.9 6126.1 6159.3 6167.4 6168.3 6177.6 5917.9 5946.7 5952.6 5971.4 5977.8 5936.7 5997.0 6096.6 6098.2 6149.4 5817.2 5871.1 5884.3 5888.0 5916.6 5929.3 5972.9 5980.1 5984.3 5996.4 5632.3 5704.7 5822.6 5864.3 5872.8 5774.1 5810.9 5819.1 5866.9 5869.4 5742.9 5758.4 5778.9 5793.2 5796.5 5666.8 5837.2 5894.0 5899.4 5925.6 5736.4 5749.1 5763.3 5782.2 5799.2 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | [#1] ext.html Cycles:180 Average:54704.36 Median:22606.84 stddev:107051.73 (473.5%) stddev-sans-first:107274.96 13:47:00 INFO - PROCESS | 19719 | Values: 598.0 633.6 639.4 651.8 652.0 37913.2 41000.4 41105.2 41131.3 41136.0 40241.6 41136.8 41303.6 41362.2 41412.0 8513.1 8732.7 8778.3 8781.0 8805.5 8341.5 8374.1 8420.3 8444.6 8450.3 8434.6 8449.3 8503.7 8519.5 8523.9 8363.2 8374.8 8395.9 8416.0 8474.5 8705.2 8766.6 8776.0 8776.9 8784.5 38314.6 38784.0 38838.6 38918.0 39195.0 3822.9 3843.2 4108.5 4163.5 4322.8 31098.7 31104.2 31322.2 31350.5 32421.8 4413.7 4499.9 4593.2 4605.3 4618.2 299332.0 299918.0 300718.0 301985.0 302440.3 34793.1 35332.6 35904.0 53939.7 54600.7 36847.0 36867.0 36905.8 37054.3 37151.8 14280.6 14322.2 14334.2 14342.9 14367.8 12295.9 12438.6 12471.9 12479.8 12494.9 8454.5 8540.7 8570.5 8589.9 8595.6 3348.5 3356.4 3369.6 3374.1 3376.3 1069.2 1088.4 1103.7 1156.9 1182.6 32059.4 32384.7 32596.5 32733.8 33490.7 1090.6 1151.7 1188.3 1204.4 1217.2 15931.5 16198.8 16224.2 16305.8 16326.8 467185.0 469783.0 470291.0 471128.0 471214.0 54398.5 54961.7 55198.7 55213.2 55333.0 1430.4 1434.6 1440.4 1440.8 1461.2 29548.9 29754.7 30017.8 30121.2 30479.7 46810.0 47684.5 47685.5 47705.5 47774.8 419656.0 420116.0 422101.0 424720.0 425394.0 26861.7 27544.9 27608.6 27693.2 27694.6 45956.0 48991.0 51627.0 53840.0 54843.7 40763.2 41962.4 42359.6 42632.4 43263.4 41281.4 41664.0 41915.8 42280.4 42799.1 36937.6 41529.4 41778.0 42083.4 42988.6 34806.0 35299.5 35716.8 36597.3 37114.4 28114.2 28883.4 29105.7 29231.4 29472.4 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | [#2] jquery.html Cycles:180 Average:28265.27 Median:20343.54 stddev:78602.33 (386.4%) stddev-sans-first:78794.94 13:47:00 INFO - PROCESS | 19719 | Values: 376.5 383.0 383.3 398.4 402.4 15407.2 17109.7 18134.6 20298.5 20388.6 17956.8 19176.6 19374.9 19898.7 19942.1 5564.9 5603.5 5747.3 5775.1 5778.5 5322.0 5604.2 5611.3 5690.3 5722.3 5300.8 5607.7 5681.0 5683.1 5694.8 5607.2 5648.6 5682.8 5685.7 5751.9 5696.9 5710.2 5715.1 5721.0 5728.8 12035.3 12100.9 12708.0 13761.7 13965.4 2252.7 2288.8 2294.2 2342.2 2379.1 10208.9 10365.2 10386.9 10440.4 10587.8 1925.0 1942.4 1943.6 2067.5 2069.9 71928.6 75541.0 84857.2 85009.6 87679.0 10118.9 10206.3 10310.3 10341.3 10684.8 11542.4 12135.2 12166.7 14149.2 14286.5 6099.0 6317.6 6777.8 7219.6 7335.9 7077.6 7123.9 7194.1 7231.9 7258.2 3744.8 3791.7 3871.5 3907.3 3948.6 1875.8 1877.4 1881.5 1885.8 1938.5 1026.3 1034.9 1082.3 1112.4 1175.3 19181.2 19510.7 19588.9 19606.2 19661.3 1061.8 1061.9 1068.7 1070.8 1080.4 10682.7 11125.5 11135.8 11145.7 11146.3 463934.0 474174.0 476978.0 478595.0 481266.0 95639.5 97164.5 98044.0 98415.5 98480.0 1051.0 1063.2 1065.5 1086.7 1108.7 17063.9 17118.0 17156.2 17207.9 17580.6 39786.8 40869.2 41328.6 41347.0 41474.6 55593.7 57109.7 57167.7 57457.7 57803.7 8550.8 8651.4 8884.5 9018.0 9018.9 12748.9 13315.2 13525.8 13536.7 13883.4 11964.2 12096.7 12114.1 12133.1 12217.1 11548.2 11910.4 12049.7 12101.9 12170.5 9503.6 12024.9 12234.9 12336.1 12495.4 7051.3 7887.3 8120.4 8569.2 8999.6 10891.0 12391.1 12401.0 12640.1 12725.1 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | [#3] mootools.html Cycles:180 Average:5793.02 Median:2398.45 stddev:3265.03 (136.1%) stddev-sans-first:3257.98 13:47:00 INFO - PROCESS | 19719 | Values: 1463.9 1511.5 1648.3 1661.9 1770.7 7722.3 8324.5 8407.1 8898.6 8900.9 8410.0 8643.6 8657.0 8705.9 8776.5 2311.1 2322.2 2327.9 2332.7 2348.1 2274.3 2275.2 2293.9 2320.6 2325.5 2306.4 2314.2 2323.5 2362.3 2385.1 2246.0 2273.1 2280.9 2289.1 2301.3 2348.2 2348.2 2374.2 2374.9 2377.6 8683.7 8775.7 8779.5 8790.6 8802.6 5222.9 5339.8 5355.2 5373.7 5375.9 3306.7 3352.1 3424.9 3460.7 3488.4 1115.3 1156.8 1163.5 1166.3 1180.1 12089.3 12105.0 12156.3 12161.6 12193.5 4419.6 4733.8 4741.1 4746.4 4775.1 10290.6 10358.4 10368.8 10370.8 10417.6 5152.4 5342.2 5362.7 5372.6 5405.2 4167.8 4679.6 4712.7 4753.6 4903.7 4015.9 4046.0 4080.1 4083.6 4143.3 1247.9 1291.5 1299.3 1304.8 1325.0 950.6 1020.6 1038.7 1057.1 1081.6 6109.0 6245.6 6278.4 6293.3 6412.4 424.4 428.7 429.4 432.9 437.2 4291.7 4355.2 4359.7 4388.5 4411.2 10453.7 10756.4 10886.6 10908.3 10981.4 10197.7 10771.6 10789.3 10867.7 10914.5 8084.8 8225.0 8264.8 8299.4 8325.0 6110.3 6253.7 6316.4 6354.2 6368.4 9985.9 10110.1 10126.7 10138.5 10213.4 10022.9 10164.1 10240.0 10256.4 10266.2 7102.4 7366.0 7556.4 7929.1 8022.4 8294.3 8320.8 8362.0 8399.4 8407.4 7351.2 7631.5 7670.5 7691.8 7716.4 7166.4 7213.8 7349.0 7396.3 7577.5 7010.3 7047.6 7056.2 7056.3 7111.8 5135.6 5205.1 5267.9 5284.1 5313.9 5414.1 5429.1 5433.4 5434.1 5447.8 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | [#4] prototype.html Cycles:180 Average:4934.57 Median:5651.65 stddev:1468.07 (26.0%) stddev-sans-first:1431.05 13:47:00 INFO - PROCESS | 19719 | Values: 336.6 338.8 345.9 347.5 348.9 5645.6 5647.6 5653.2 5668.2 5701.8 5579.7 5584.5 5590.2 5600.5 5602.6 4113.3 4231.4 4316.9 4334.9 4361.6 4347.9 4349.7 4351.1 4368.7 4368.9 4354.8 4355.3 4364.4 4377.3 4381.9 4266.2 4268.3 4316.4 4322.9 4332.8 3812.3 3824.4 3831.0 3840.1 3855.8 5342.9 5365.7 5402.8 5404.3 5405.9 4924.4 4980.3 4991.3 4992.4 4996.7 5802.6 5810.4 5820.3 5860.1 5862.4 4227.5 4252.6 4259.6 4264.9 4296.6 5801.5 6085.8 6095.7 6101.1 6201.0 4156.8 4174.9 4199.9 4210.1 4213.4 4266.4 4277.2 4279.7 4280.3 4288.9 4789.0 4918.9 4926.4 4953.0 4955.7 5778.3 5887.3 5889.3 5920.3 5963.6 1431.0 1431.2 1437.2 1458.2 1458.5 947.1 961.6 961.8 962.9 964.9 5513.9 5526.5 5558.5 5560.3 5564.9 5876.8 5892.9 5893.3 5924.4 5934.1 5381.8 5547.4 5763.5 5767.2 5770.6 3127.2 3189.2 3194.5 3201.7 3201.9 6115.5 6132.0 6213.3 6230.8 6279.0 6086.2 6096.0 6099.5 6185.2 6196.8 6110.9 6115.3 6195.7 6214.8 6238.5 5699.1 6055.8 6110.3 6201.1 6205.7 6011.4 6059.0 6076.4 6077.5 6100.8 6151.8 6295.4 6312.6 6316.9 6346.1 4253.9 4274.6 4278.3 4281.5 4293.4 5815.6 5931.6 6137.4 6168.7 6177.8 5859.9 5866.7 5866.8 5893.7 5921.6 5810.9 5900.2 5904.3 5919.5 5919.8 5571.6 5773.3 5804.4 5809.2 5830.3 5882.7 5904.6 5915.7 5945.3 5964.9 5650.2 5789.5 5794.4 5799.0 5857.6 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - PROCESS | 19719 | [#5] yui.html Cycles:180 Average:14707.90 Median:23861.11 stddev:16717.19 (70.1%) stddev-sans-first:16731.57 13:47:00 INFO - PROCESS | 19719 | Values: 822.9 845.0 847.2 871.7 875.3 14560.6 14660.0 14667.0 14737.7 14855.9 13975.8 13987.7 13988.4 13992.4 13995.6 670.1 798.9 820.9 823.7 825.3 805.8 814.5 815.0 816.6 818.5 870.5 873.3 874.5 877.4 878.4 862.4 863.4 866.4 867.5 867.5 634.0 637.5 637.6 638.3 640.2 14113.8 14123.2 14130.0 14137.9 14166.0 14086.5 14112.3 14213.0 14328.4 14562.0 11423.6 11463.3 11580.5 11721.8 11823.9 3860.7 3908.7 3914.1 3966.6 4092.2 52696.0 53899.7 56124.2 56363.7 56505.4 11206.8 11229.6 11239.2 11301.4 11333.4 20420.7 20569.5 20586.6 20621.9 20636.8 8059.7 8225.2 8557.1 8746.7 8791.3 4596.0 4656.4 4671.3 4688.7 4738.7 3213.5 3363.9 3364.2 3371.4 3388.6 609.3 621.9 626.3 627.5 634.1 622.1 642.3 720.8 735.3 758.4 8531.3 8932.4 9065.0 9102.0 9176.4 676.9 706.7 728.3 734.4 744.8 4196.5 4231.2 4242.3 4301.2 4368.6 62341.1 62495.0 62727.1 64266.4 64304.0 27777.7 27998.3 49934.0 50447.5 57360.0 51365.2 52247.7 52720.0 53241.0 55043.0 9535.7 9568.4 9817.4 9848.0 9911.0 31905.8 32807.7 32864.2 33194.2 34360.3 43421.0 44252.0 44307.1 44516.8 45224.0 11555.9 11645.7 11656.4 12013.7 12918.9 13529.5 13535.0 13820.9 14120.7 14338.3 13091.7 13156.4 13157.1 13172.2 13198.3 12604.5 12621.6 12851.8 13145.0 13231.9 12992.2 13084.5 13120.1 13369.1 13563.7 10841.9 10894.7 11003.6 11182.8 11537.9 10813.5 11168.2 11236.7 11260.8 11372.4 13:47:00 INFO - PROCESS | 19719 | -------- Summary: end -------- 13:47:00 INFO - PROCESS | 19719 | 13:47:00 INFO - TEST-INFO | 19719: exit 0 13:47:00 INFO - TEST-OK | dromaeo_css | took 1110582ms 13:47:00 INFO - TEST-START | kraken 13:47:00 INFO - operating with platform_type : linux_ 13:47:00 INFO - Initialising browser for kraken test... 13:47:00 INFO - TEST-INFO | started process 19955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9lgU2H/profile http://localhost:46114/getInfo.html) 13:47:04 INFO - PROCESS | 19955 | 13:47:04 INFO - PROCESS | 19955 | (process:20024): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:47:05 INFO - PROCESS | 19955 | __metrics Screen width/height:1600/1200 13:47:05 INFO - PROCESS | 19955 | colorDepth:24 13:47:05 INFO - PROCESS | 19955 | Browser inner width/height: 1024/697 13:47:05 INFO - PROCESS | 19955 | __metrics 13:47:05 ERROR - PROCESS | 19955 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:47:06 INFO - TEST-INFO | 19955: exit 0 13:47:06 INFO - Browser initialized. 13:47:06 INFO - Running cycle 1/1 for kraken test... 13:47:06 INFO - TEST-INFO | started process 20075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9lgU2H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:47:08 INFO - PROCESS | 20075 | 13:47:08 INFO - PROCESS | 20075 | (process:20135): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:47:18 INFO - PROCESS | 20075 | RSS: Main: 164696064 13:47:18 INFO - PROCESS | 20075 | 13:47:20 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-beat-detection) 13:47:21 INFO - PROCESS | 20075 | RSS: Main: 169123840 13:47:21 INFO - PROCESS | 20075 | 13:47:24 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-dft) 13:47:25 INFO - PROCESS | 20075 | RSS: Main: 171159552 13:47:25 INFO - PROCESS | 20075 | 13:47:27 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-fft) 13:47:28 INFO - PROCESS | 20075 | RSS: Main: 162684928 13:47:28 INFO - PROCESS | 20075 | 13:47:30 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46114/tests/kraken/driver.html?testName=audio-oscillator) 13:47:31 INFO - PROCESS | 20075 | RSS: Main: 163581952 13:47:31 INFO - PROCESS | 20075 | 13:47:33 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46114/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:34 INFO - PROCESS | 20075 | RSS: Main: 164450304 13:47:34 INFO - PROCESS | 20075 | 13:47:37 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46114/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:37 INFO - PROCESS | 20075 | RSS: Main: 164663296 13:47:37 INFO - PROCESS | 20075 | 13:47:41 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46114/tests/kraken/driver.html?testName=imaging-desaturate) 13:47:41 INFO - PROCESS | 20075 | RSS: Main: 164790272 13:47:41 INFO - PROCESS | 20075 | 13:47:44 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46114/tests/kraken/driver.html?testName=json-parse-financial) 13:47:45 INFO - PROCESS | 20075 | RSS: Main: 167182336 13:47:45 INFO - PROCESS | 20075 | 13:47:46 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46114/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:47:47 INFO - PROCESS | 20075 | RSS: Main: 166932480 13:47:47 INFO - PROCESS | 20075 | 13:47:49 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:49 INFO - PROCESS | 20075 | RSS: Main: 167034880 13:47:49 INFO - PROCESS | 20075 | 13:47:51 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:52 INFO - PROCESS | 20075 | RSS: Main: 167182336 13:47:52 INFO - PROCESS | 20075 | 13:47:55 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:55 INFO - PROCESS | 20075 | RSS: Main: 167587840 13:47:55 INFO - PROCESS | 20075 | 13:47:58 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:59 INFO - PROCESS | 20075 | RSS: Main: 166957056 13:47:59 INFO - PROCESS | 20075 | 13:48:00 INFO - PROCESS | 20075 | Cycle 1(1): loaded http://localhost:46114/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46114/tests/kraken/driver.html?testName=ai-astar) 13:48:01 INFO - PROCESS | 20075 | RSS: Main: 168685568 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | __start_tp_report 13:48:01 INFO - PROCESS | 20075 | _x_x_mozilla_page_load 13:48:01 INFO - PROCESS | 20075 | _x_x_mozilla_page_load_details 13:48:01 INFO - PROCESS | 20075 | |i|pagename|runs| 13:48:01 INFO - PROCESS | 20075 | |0;ai-astar;113;106;112;112;111;114;114;110;111;111 13:48:01 INFO - PROCESS | 20075 | |1;audio-beat-detection;159;136;154;184;127;166;161;127;184;127 13:48:01 INFO - PROCESS | 20075 | |2;audio-dft;163;163;163;160;162;165;178;160;167;162 13:48:01 INFO - PROCESS | 20075 | |3;audio-fft;74;75;75;165;77;75;75;76;161;76 13:48:01 INFO - PROCESS | 20075 | |4;audio-oscillator;93;93;157;92;92;92;153;92;92;163 13:48:01 INFO - PROCESS | 20075 | |5;imaging-gaussian-blur;118;118;117;117;117;118;117;122;118;118 13:48:01 INFO - PROCESS | 20075 | |6;imaging-darkroom;146;146;147;146;147;147;146;146;146;146 13:48:01 INFO - PROCESS | 20075 | |7;imaging-desaturate;96;96;95;95;96;95;95;95;96;95 13:48:01 INFO - PROCESS | 20075 | |8;json-parse-financial;62;58;62;59;58;61;60;76;56;56 13:48:01 INFO - PROCESS | 20075 | |9;json-stringify-tinderbox;58;58;58;58;60;58;58;58;58;58 13:48:01 INFO - PROCESS | 20075 | |10;stanford-crypto-aes;79;80;80;80;84;80;84;81;81;81 13:48:01 INFO - PROCESS | 20075 | |11;stanford-crypto-ccm;130;126;133;133;135;132;134;135;161;130 13:48:01 INFO - PROCESS | 20075 | |12;stanford-crypto-pbkdf2;173;174;171;167;183;169;169;171;170;169 13:48:01 INFO - PROCESS | 20075 | |13;stanford-crypto-sha256-iterative;66;69;68;69;65;68;65;66;65;68 13:48:01 INFO - PROCESS | 20075 | __end_tp_report 13:48:01 INFO - PROCESS | 20075 | __start_cc_report 13:48:01 INFO - PROCESS | 20075 | _x_x_mozilla_cycle_collect,878 13:48:01 INFO - PROCESS | 20075 | __end_cc_report 13:48:01 INFO - PROCESS | 20075 | __startTimestamp1462567681112__endTimestamp 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | ------- Summary: start ------- 13:48:01 INFO - PROCESS | 20075 | Number of tests: 14 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.32 (2.1%) stddev-sans-first:2.39 13:48:01 INFO - PROCESS | 20075 | Values: 113.0 106.0 112.0 112.0 111.0 114.0 114.0 110.0 111.0 111.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:160.00 stddev:22.38 (14.0%) stddev-sans-first:23.61 13:48:01 INFO - PROCESS | 20075 | Values: 159.0 136.0 154.0 184.0 127.0 166.0 161.0 127.0 184.0 127.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:5.25 (3.2%) stddev-sans-first:5.55 13:48:01 INFO - PROCESS | 20075 | Values: 163.0 163.0 163.0 160.0 162.0 165.0 178.0 160.0 167.0 162.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:36.97 (49.3%) stddev-sans-first:38.57 13:48:01 INFO - PROCESS | 20075 | Values: 74.0 75.0 75.0 165.0 77.0 75.0 75.0 76.0 161.0 76.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#4] audio-oscillator Cycles:10 Average:111.90 Median:92.00 stddev:31.67 (34.4%) stddev-sans-first:32.85 13:48:01 INFO - PROCESS | 20075 | Values: 93.0 93.0 157.0 92.0 92.0 92.0 153.0 92.0 92.0 163.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.49 (1.3%) stddev-sans-first:1.58 13:48:01 INFO - PROCESS | 20075 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 117.0 122.0 118.0 118.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:48:01 INFO - PROCESS | 20075 | Values: 146.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:48:01 INFO - PROCESS | 20075 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:60.50 stddev:5.77 (9.5%) stddev-sans-first:6.10 13:48:01 INFO - PROCESS | 20075 | Values: 62.0 58.0 62.0 59.0 58.0 61.0 60.0 76.0 56.0 56.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 13:48:01 INFO - PROCESS | 20075 | Values: 58.0 58.0 58.0 58.0 60.0 58.0 58.0 58.0 58.0 58.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:1.70 (2.1%) stddev-sans-first:1.64 13:48:01 INFO - PROCESS | 20075 | Values: 79.0 80.0 80.0 80.0 84.0 80.0 84.0 81.0 81.0 81.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:133.50 stddev:9.57 (7.2%) stddev-sans-first:9.99 13:48:01 INFO - PROCESS | 20075 | Values: 130.0 126.0 133.0 133.0 135.0 132.0 134.0 135.0 161.0 130.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.00 stddev:4.50 (2.6%) stddev-sans-first:4.75 13:48:01 INFO - PROCESS | 20075 | Values: 173.0 174.0 171.0 167.0 183.0 169.0 169.0 171.0 170.0 169.0 13:48:01 INFO - PROCESS | 20075 | 13:48:01 INFO - PROCESS | 20075 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:68.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 13:48:01 INFO - PROCESS | 20075 | Values: 66.0 69.0 68.0 69.0 65.0 68.0 65.0 66.0 65.0 68.0 13:48:01 INFO - PROCESS | 20075 | -------- Summary: end -------- 13:48:01 INFO - PROCESS | 20075 | 13:48:02 INFO - TEST-INFO | 20075: exit 0 13:48:02 INFO - TEST-OK | kraken | took 61223ms 13:48:02 INFO - SUITE-END | took 1171s 13:48:02 INFO - Completed test suite (00:19:31) 13:48:02 INFO - javascript benchmark 13:48:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3206.374756922401, 3246.8214248216345, 3247.464168412212, 3258.5763850699404, 3264.689854463825, 5582.6929518876495, 5620.325560932689, 5631.5213206877415, 5645.661260324373, 5682.573806964484, 5435.945640543593, 5531.115021596545, 5574.60977731559, 5586.13414920687, 5587.357453892803, 5008.7245201514, 5036.546710796028, 5095.643304968654, 5187.636865419422, 5195.038917800201, 5110.233464980245, 5214.661047031931, 5234.921476177841, 5243.764030618631, 5260.105782017047, 4873.902521949559, 4947.678400903929, 4989.825356112555, 5119.820806271781, 5126.0, 5036.244563315496, 5048.9495105048845, 5053.620978426633, 5053.646244762868, 5087.516685914832, 4993.076280888047, 5006.824761133343, 5009.398872135331, 5015.122353588144, 5045.344105266292, 5348.946510534884, 5383.2194331821665, 5414.29614150158, 5449.5640348772, 5499.890002199933, 5979.282486101695, 5994.190784244115, 5996.97001514994, 6000.33996260411, 6001.819945401601, 6048.758049678007, 6048.818535443944, 6050.546209034296, 6052.878942421171, 6056.242969628796, 5364.91952620711, 5526.171074338841, 5530.419305972895, 5548.167774833726, 5625.268715067097, 6111.266648002268, 6121.265448146251, 6151.415615516519, 6151.96924015377, 6152.384761523812, 5673.914891276634, 5897.0, 5912.201852749909, 5921.052631579013, 5921.851953701192, 5965.463108320272, 6045.758169673164, 6047.425494578008, 6113.266408031065, 6119.0, 5708.143778433268, 5909.527237820964, 5928.318243401977, 6005.879882402415, 6078.179445774852, 5768.278965129359, 5952.345242023374, 6024.126501657235, 6036.2756469223095, 6069.908951365733, 4456.844010459618, 4472.08322293929, 4499.167653984024, 4505.279155335196, 4510.255807791677, 3988.441618173458, 3998.04047028711, 4011.338129208648, 4033.3748269018347, 4044.595540445932, 5520.585956053312, 5635.718214089279, 5707.0, 5721.027425337703, 5747.166660834156, 5954.612950158313, 6023.427774361428, 6049.727762250709, 6056.848578785478, 6063.0, 5686.658800471985, 5702.714864256771, 5719.828405147852, 5745.798897038583, 5763.077907534858, 4951.356323677899, 5046.293518907356, 5075.644704870698, 5137.0, 5161.896762064737, 6126.111713801563, 6159.260888693296, 6167.444929956326, 6168.321484636686, 6177.598456100339, 5917.940820591911, 5946.672932988728, 5952.642841429528, 5971.4327138921735, 5977.820665380045, 5936.703164841827, 5996.970015149896, 6096.573239873166, 6098.207233059674, 6149.354317796567, 5817.243758311392, 5871.119332100048, 5884.323302820059, 5888.0, 5916.615419997686, 5929.318128415288, 5972.910406343822, 5980.102984552352, 5984.31180414258, 5996.400359963969, 5632.324121105494, 5704.657720536781, 5822.563307752021, 5864.266966629171, 5872.823815285548, 5774.133879918046, 5810.912836307374, 5819.0689489681445, 5866.853328666817, 5869.354371019099, 5742.885142297214, 5758.366579676149, 5778.85552861165, 5793.15999180125, 5796.507296879644, 5666.829995100154, 5837.153612726216, 5894.0, 5899.439553242435, 5925.555583331354, 5736.397678243724, 5749.108888122348, 5763.250777398911, 5782.1615865698395, 5799.159121927212], "value": 5494.6767953331855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.0192484325704, 633.5565104426901, 639.3989649729255, 651.8044586624012, 651.9608823470592, 37913.24173516528, 41000.384994225074, 41105.17789644205, 41131.326463779835, 41136.0, 40241.59758402415, 41136.794316028376, 41303.58696413035, 41362.17275654485, 41412.0, 8513.106123856998, 8732.694355697551, 8778.341624378165, 8781.0, 8805.515696636683, 8341.499510029387, 8374.078851326349, 8420.326373890104, 8444.57777111142, 8450.323974082059, 8434.62044208009, 8449.32405407569, 8503.65985360588, 8519.53142577158, 8523.872141917876, 8363.20549547792, 8374.83250334993, 8395.916040839575, 8415.999999999969, 8474.491530508189, 8705.216530512283, 8766.605502752327, 8776.034636190014, 8776.868346974801, 8784.51685157316, 38314.61685383139, 38784.0, 38838.611613884066, 38918.0, 39195.0, 3822.9044273893096, 3843.1929294848114, 4108.50697916249, 4163.500379954425, 4322.82708691652, 31098.689013110034, 31104.222394440094, 31322.21694457634, 31350.52974205389, 32421.83789081063, 4413.735175889425, 4499.887502812423, 4593.150267200579, 4605.332226827091, 4618.191816432144, 299332.0, 299918.0049197055, 300718.0, 301985.0, 302440.3413778119, 34793.13017174591, 35332.64667353345, 35904.0, 53939.730301348245, 54600.72699636476, 36847.0, 36867.0, 36905.81547092248, 37054.258914821556, 37151.81424092862, 14280.642983925278, 14322.212278324583, 14334.21161836109, 14342.856571434151, 14367.78448323276, 12295.877041229473, 12438.626841194779, 12471.875281247252, 12479.75040499185, 12494.875051249372, 8454.492730436194, 8540.70107546233, 8570.48577085377, 8589.871151932726, 8595.570221489026, 3348.464245720673, 3356.429407000767, 3369.646187150363, 3374.1395944034116, 3376.324735052999, 1069.2301542889106, 1088.4231357380602, 1103.6799328194895, 1156.8669602995594, 1182.5565412970136, 32059.35881282361, 32384.676153238164, 32596.511052334234, 32733.836330818194, 33490.665093348754, 1090.6455401994224, 1151.6775302915198, 1188.2632767683917, 1204.4158583087196, 1217.1662411248324, 15931.522054338388, 16198.838011619733, 16224.188790560425, 16305.755413668805, 16326.836731632531, 467185.0, 469783.0, 470291.0, 471128.0, 471214.0, 54398.45601544013, 54961.725191373785, 55198.724006379714, 55213.17180242299, 55333.0, 1430.399232322427, 1434.583970648521, 1440.4310297432455, 1440.7910852926268, 1461.218248237188, 29548.852255738584, 29754.70245297606, 30017.849910750305, 30121.246968825955, 30479.695203048574, 46810.0, 47684.5231547694, 47685.52314476811, 47705.522944770106, 47774.76112619415, 419656.0, 420116.0, 422101.0, 424720.0, 425394.0, 26861.731382685924, 27544.934129939935, 27608.585871212348, 27693.169204923885, 27694.584581231702, 45956.0, 48991.0, 51627.0, 53840.0, 54843.725781370835, 40763.184736304516, 41962.37056444217, 42359.576404235566, 42632.360514592925, 43263.35104973365, 41281.380779287734, 41664.0, 41915.79042104892, 42280.365794512494, 42799.14401711886, 36937.63062369342, 41529.37705934353, 41778.0, 42083.36874946817, 42988.570114298454, 34806.0, 35299.470507941885, 35716.82141589275, 36597.268054638225, 37114.44328335023, 28114.156575302775, 28883.422331552832, 29105.708942911147, 29231.415371692023, 29472.41055178927], "value": 18531.6467535935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.5199370802227, 382.969362451004, 383.313868175965, 398.43621275894577, 402.39640539191214, 15407.152606606633, 17109.657806843854, 18134.63730725388, 20298.492537686547, 20388.592228155445, 17956.820431795677, 19176.616467670672, 19374.903125484387, 19898.70151947722, 19942.102605382755, 5564.944350556483, 5603.476230624551, 5747.281589801275, 5775.1337299405, 5778.508826749731, 5322.0, 5604.159376093598, 5611.3266408031095, 5690.317161940573, 5722.256106706143, 5300.761465734032, 5607.7476513556785, 5680.971595142039, 5683.062294721366, 5694.829155125353, 5607.186957891124, 5648.604597678164, 5682.772689092472, 5685.715714214293, 5751.884962300752, 5696.857578560528, 5710.200571919934, 5715.057015592422, 5721.027425337703, 5728.770849166029, 12035.27788332694, 12100.939495302555, 12708.0, 13761.655958601015, 13965.3715582798, 2252.650839119939, 2288.8168946484243, 2294.2314324701247, 2342.203650758733, 2379.131616959797, 10208.948955255251, 10365.17078633715, 10386.948065259701, 10440.37357758537, 10587.78824423515, 1924.980750192494, 1942.3784388995527, 1943.620993906189, 2067.514134178467, 2069.927552535654, 71928.64035679841, 75541.0, 84857.15142848616, 85009.57495212546, 87679.0, 10118.949405252926, 10206.336588121749, 10310.278280520291, 10341.276110672181, 10684.839727404094, 11542.365169915734, 12135.15053946233, 12166.695832604255, 14149.151050936976, 14286.499972500913, 6098.969505152446, 6317.5893566918, 6777.762778302736, 7219.602921839244, 7335.853282934311, 7077.610731409822, 7123.89314160288, 7194.064771579766, 7231.927680723125, 7258.165310989199, 3744.812759362021, 3791.658750712449, 3871.5160604924386, 3907.257621051991, 3948.6446219840354, 1875.7749070111674, 1877.4461533847548, 1881.4543782303253, 1885.849132069431, 1938.5347516595916, 1026.2662196529518, 1034.8706411698538, 1082.3451811653836, 1112.3548341961643, 1175.2713317743055, 19181.232750690095, 19510.70733938992, 19588.90205548963, 19606.215751369786, 19661.311854085037, 1061.7611037516497, 1061.877884043345, 1068.71144790906, 1070.7751372211767, 1080.3841810168285, 10682.732931676615, 11125.499352529156, 11135.777284454265, 11145.665630031112, 11146.275492092987, 463934.0, 474174.0, 476978.0, 478595.0, 481266.0, 95639.52180239193, 97164.51417743007, 98044.0, 98415.50792245993, 98480.0, 1051.033049594375, 1063.1813503602184, 1065.5098654618962, 1086.7446150154708, 1108.7394462301352, 17063.91468042652, 17118.0, 17156.15725898536, 17207.913960430116, 17580.648387032445, 39786.80106599564, 40869.1826163481, 41328.58671413247, 41347.0, 41474.585254147074, 55593.72203138958, 57109.714451429136, 57167.71416142893, 57457.71271143617, 57803.71098144483, 8550.78623034429, 8651.351148663749, 8884.466931984101, 9017.954910225408, 9018.86471702938, 12748.936255318664, 13315.201087934754, 13525.797113043509, 13536.729265414833, 13883.444662213802, 11964.222325548812, 12096.697582560506, 12114.091443141975, 12133.09001824849, 12217.083718720954, 11548.191626586058, 11910.404479775803, 12049.68882398802, 12101.939490302491, 12170.45232964501, 9503.57446383048, 12024.939875300568, 12234.938825305817, 12336.074794390635, 12495.437705303464, 7051.330123638246, 7887.329576986021, 8120.431569790058, 8569.228769410784, 8999.595018224065, 10891.0, 12391.132620716464, 12401.0, 12640.051996100514, 12725.109242353317], "value": 8952.257676449242, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.9048461849975, 1511.4936496273747, 1648.2665213979776, 1661.941832035879, 1770.6989811731996, 7722.304992550669, 8324.542150181738, 8407.117252688457, 8898.555072246387, 8900.91099089009, 8410.0, 8643.611037503311, 8657.0, 8705.912940870588, 8776.517291548962, 2311.075569772092, 2322.2336628912503, 2327.8719670418122, 2332.7317358503733, 2348.1311914591624, 2274.2949685597437, 2275.203678712454, 2293.8738369389675, 2320.5590937721863, 2325.465143017107, 2306.423394151462, 2314.2247347138727, 2323.500447403808, 2362.3267368799898, 2385.129427758864, 2245.9663105053437, 2273.102124660766, 2280.8859557022247, 2289.095807156181, 2301.2866011536476, 2348.2016114521143, 2348.2368230325214, 2374.169040835711, 2374.893129809163, 2377.5601513720017, 8683.696070637498, 8775.692850750256, 8779.517126558037, 8790.604422800989, 8802.64789408423, 5222.92165617516, 5339.839804805862, 5355.196720491918, 5373.650712703662, 5375.892482150335, 3306.6528014558367, 3352.122362932276, 3424.8630054797777, 3460.7058400036026, 3488.4069708149677, 1115.252780636975, 1156.7512984708244, 1163.4880652512952, 1166.3177041430772, 1180.0559552358166, 12089.335086570236, 12105.0, 12156.331401772988, 12161.635150945398, 12193.45129469176, 4419.558044195554, 4733.786979585927, 4741.075490279362, 4746.382970213919, 4775.116603428377, 10290.639827606148, 10358.430286334173, 10368.844467332996, 10370.792584148276, 10417.5832966682, 5152.355955505562, 5342.198670199501, 5362.678239305576, 5372.570194384518, 5405.243265942771, 4167.791610419466, 4679.64902632304, 4712.740799256074, 4753.5959443447, 4903.656744027884, 4015.91968160641, 4046.0, 4080.0615858352744, 4083.612056854594, 4143.295639741251, 1247.8502579690496, 1291.5156816193928, 1299.330844615024, 1304.8368953880765, 1324.9536266230637, 950.5579905344048, 1020.6274709730894, 1038.6832016234969, 1057.1489950589848, 1081.6106201767357, 6108.969455152785, 6245.594036387711, 6278.434940855345, 6293.339199383999, 6412.35876412355, 424.37404827878635, 428.70847823480335, 429.364540480085, 432.9437173167468, 437.1911962868667, 4291.721038132511, 4355.237833379146, 4359.716618419792, 4388.4953230378915, 4411.228035093845, 10453.68638940833, 10756.354618722902, 10886.61896833607, 10908.34549927007, 10981.3960232188, 10197.694069177936, 10771.6229931952, 10789.29869558492, 10867.728306792393, 10914.508847101899, 8084.83830323402, 8224.958875205706, 8264.752057438287, 8299.377546684023, 8325.0, 6110.297315808739, 6253.656048917172, 6316.399942005502, 6354.205724284465, 6368.395002474757, 9985.900140998498, 10110.09009189147, 10126.696199114038, 10138.493075346056, 10213.387196768217, 10022.899771002489, 10164.136048435967, 10240.027197416233, 10256.43589602579, 10266.178705703376, 7102.431805455654, 7366.042414486083, 7556.395488360808, 7929.127795942326, 8022.358211343195, 8294.336453083619, 8320.750377488685, 8361.95819020901, 8399.370047246603, 8407.411481196257, 7351.154617219088, 7631.465797394129, 7670.539767613961, 7691.846163076819, 7716.382689384948, 7166.355028047292, 7213.783586492414, 7348.96325518369, 7396.297351751575, 7577.5453472791805, 7010.334018268461, 7047.577145371294, 7056.223815380406, 7056.259092795182, 7111.751088711871, 5135.640505164752, 5205.141151709925, 5267.920981185209, 5284.101702710472, 5313.946860531345, 5414.10667239901, 5429.104197807475, 5433.429489903661, 5434.1033729435785, 5447.836564903059], "value": 4576.057653609329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.5574269835167, 338.80688007835545, 345.90833429141276, 347.4544964405884, 348.8988193423909, 5645.604807663465, 5647.632903861246, 5653.1520271959225, 5668.178114173443, 5701.828945131648, 5579.69311687858, 5584.5253153482, 5590.18942253373, 5600.4959553640165, 5602.60781745277, 4113.280175969208, 4231.386448964899, 4316.935245971313, 4334.913301733964, 4361.5856493633055, 4347.869563913072, 4349.717268377545, 4351.108022855323, 4368.650507959372, 4368.907773056736, 4354.847580334689, 4355.346697995295, 4364.406991448114, 4377.277749171399, 4381.912361752763, 4266.189424009443, 4268.338407546819, 4316.417283666696, 4322.891927701801, 4332.826686932519, 3812.275667623143, 3824.3937546230372, 3830.9808450957566, 3840.116773142193, 3855.7879316637573, 5342.893142137174, 5365.651232669864, 5402.837914862521, 5404.270423492818, 5405.891882162335, 4924.409070911478, 4980.306695723435, 4991.276264941599, 4992.40091189056, 4996.700197988096, 5802.578368299752, 5810.448007439329, 5820.272465941757, 5860.120981852713, 5862.443067908542, 4227.450431443893, 4252.617264446215, 4259.5740425957465, 4264.893377665552, 4296.63478604319, 5801.506871915893, 6085.752420753734, 6095.725692343811, 6101.125785126433, 6200.968995155041, 4156.7921603919685, 4174.91650167001, 4199.853005144805, 4210.052738133895, 4213.377849527954, 4266.360045993126, 4277.2087163874785, 4279.700420970502, 4280.272353699816, 4288.871333859989, 4788.976055119702, 4918.90162196754, 4926.359573255454, 4953.0, 4955.653104282737, 5778.3354914184565, 5887.263257339096, 5889.263842019747, 5920.2895652521975, 5963.642181469126, 1431.0, 1431.2485944879022, 1437.173625165534, 1458.1688437590683, 1458.4749490183526, 947.1144479911168, 961.5961296255589, 961.8172547216006, 962.8748262725801, 964.8697425847421, 5513.862153446196, 5526.45259327389, 5558.527525160407, 5560.277163968658, 5564.914841605848, 5876.794312199053, 5892.941070589325, 5893.322267939242, 5924.437178468039, 5934.13954976526, 5381.811636592701, 5547.446714919829, 5763.510101641324, 5767.22142510764, 5770.6249093808765, 3127.2338277121794, 3189.2345836999416, 3194.536792165123, 3201.7193122751087, 3201.8719251230154, 6115.534389959553, 6132.018876979661, 6213.285472170758, 6230.813075607739, 6279.0, 6086.239220097488, 6095.969520152459, 6099.481544068715, 6185.226846644169, 6196.845078873064, 6110.938890611126, 6115.327313995457, 6195.721192546346, 6214.844628884314, 6238.469730072904, 5699.116636921284, 6055.848603784941, 6110.297315808739, 6201.131841542097, 6205.720742566505, 6011.428914253313, 6058.969705151446, 6076.4201307661215, 6077.453029227391, 6100.847478813065, 6151.846203844761, 6295.433410993032, 6312.621242725451, 6316.873662526816, 6346.079818426395, 4253.8723838284905, 4274.5939135782055, 4278.336857787048, 4281.529031806561, 4293.355996600535, 5815.563832712648, 5931.555133364928, 6137.447629713169, 6168.722407491763, 6177.84555386119, 5859.882802344015, 5866.682660349224, 5866.794662186803, 5893.705314734332, 5921.585489015728, 5810.94189058104, 5900.232969713909, 5904.3210030847, 5919.526437884872, 5919.7864437789285, 5571.609987301013, 5773.278340207474, 5804.419558044162, 5809.186713859978, 5830.2889156542415, 5882.7352119294555, 5904.61619994699, 5915.733791979457, 5945.34601193877, 5964.880702385841, 5650.152477128299, 5789.507891829242, 5794.420557944172, 5798.985177593989, 5857.602590497416], "value": 4460.0777021843305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.8806823010664, 844.9873251901223, 847.2163248994678, 871.7341210930664, 875.3434923807145, 14560.56318310451, 14660.0, 14667.0, 14737.70524589509, 14855.925720371397, 13975.79036314456, 13987.65030874226, 13988.440462381492, 13992.440302387919, 13995.580132596013, 670.1121014655589, 798.9480683755537, 820.9055958564782, 823.6952327638782, 825.2737590919982, 805.8468890910708, 814.5357146426539, 815.0, 816.6284340625001, 818.54161669465, 870.5299138465222, 873.2795443758893, 874.5452364770316, 877.4121338703052, 878.3939082033377, 862.4437237981498, 863.4258218284833, 866.4108406283724, 867.4535042922918, 867.5185272173941, 634.0109429290276, 637.5314144104079, 637.5600835423589, 638.294684373765, 640.2445114764575, 14113.78829317561, 14123.223222722747, 14130.0, 14137.85862141386, 14166.0, 14086.506972255922, 14112.294385280695, 14213.0, 14328.355224014944, 14562.0, 11423.600173993871, 11463.31220126795, 11580.536778528849, 11721.824172637333, 11823.940880295544, 3860.7297489175767, 3908.687305015592, 3914.099757055893, 3966.6231707987695, 4092.1815636872743, 52696.0, 53899.73050134724, 56124.15813762838, 56363.71818140924, 56505.43494565043, 11206.775864482664, 11229.606963756392, 11239.157063220291, 11301.378424186585, 11333.43332833355, 20420.693689594667, 20569.48576285605, 20586.58826823455, 20621.865797381288, 20636.79363206379, 8059.677612895536, 8225.218604232588, 8557.144285571392, 8746.650133994695, 8791.252743516745, 4596.0, 4656.371389862393, 4671.27595222741, 4688.671792974527, 4738.691985020962, 3213.501907204387, 3363.882264120744, 3364.2094107884627, 3371.359441706068, 3388.5764279465066, 609.2688773471851, 621.8725161341914, 626.2891618013588, 627.5450298533618, 634.1154090044362, 622.1290193728726, 642.2998931165052, 720.7585458871232, 735.3381956239427, 758.4311766175368, 8531.317494600416, 8932.436823555852, 9065.0, 9101.954490227507, 9176.44941303524, 676.8646270745772, 706.7490541741089, 728.2571776787753, 734.3941248470034, 744.757953665061, 4196.531214075049, 4231.217224813419, 4242.321228603409, 4301.2257793597455, 4368.628666563378, 62341.064884026775, 62495.0, 62727.059094113625, 64266.357336426976, 64304.0, 27777.722222777917, 27998.3000424991, 49934.0, 50447.49552504428, 57360.0, 51365.22952155721, 52247.73876130671, 52720.0, 53241.0, 55043.0, 9535.713928582154, 9568.378055426376, 9817.410955342702, 9848.0, 9911.0, 31905.8404707975, 32807.67192328046, 32864.1783955403, 33194.170145746546, 34360.312793743484, 43421.0, 44252.0, 44307.11385772331, 44516.777416114004, 45224.0, 11555.942220288845, 11645.708857278636, 11656.417179140839, 12013.699657508632, 12918.932970725014, 13529.458821647024, 13535.0, 13820.861791381958, 14120.717585648024, 14338.283085845875, 13091.67270818199, 13156.407961641558, 13157.144785588906, 13172.209667419986, 13198.274094924871, 12604.495820167458, 12621.558245461365, 12851.807222891852, 13145.0, 13231.867681323063, 12992.155509891827, 13084.542041028519, 13120.081594288307, 13369.131006484547, 13563.660908477366, 10841.891581084405, 10894.67315980522, 11003.61487347939, 11182.832257516306, 11537.884621154017, 10813.51339189754, 11168.162387820783, 11236.719082023015, 11260.774784504429, 11372.374519401512], "value": 6804.312558895004, "unit": "score"}], "name": "dromaeo_css", "value": 7086.107065708372, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 112.0, 111.0, 114.0, 114.0, 110.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 136.0, 154.0, 184.0, 127.0, 166.0, 161.0, 127.0, 184.0, 127.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 160.0, 162.0, 165.0, 178.0, 160.0, 167.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 165.0, 77.0, 75.0, 75.0, 76.0, 161.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 157.0, 92.0, 92.0, 92.0, 153.0, 92.0, 92.0, 163.0], "value": 111.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 122.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 62.0, 59.0, 58.0, 61.0, 60.0, 76.0, 56.0, 56.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 60.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 80.0, 84.0, 80.0, 84.0, 81.0, 81.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 133.0, 133.0, 135.0, 132.0, 134.0, 135.0, 161.0, 130.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 171.0, 167.0, 183.0, 169.0, 169.0, 171.0, 170.0, 169.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 69.0, 65.0, 68.0, 65.0, 66.0, 65.0, 68.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1566.1000000000001, "alertThreshold": 2.0}]} 13:48:02 INFO - Return code: 0 13:48:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:48:02 ERROR - # TBPL SUCCESS # 13:48:02 INFO - Running post-action listener: _resource_record_post_action 13:48:02 INFO - Running post-run listener: _resource_record_post_run 13:48:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 545271808; Read time: 12; Write time: 469760 13:48:03 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251682816; Read time: 0; Write time: 264628 13:48:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293588992; Read time: 12; Write time: 205132 13:48:03 INFO - Running post-run listener: _upload_blobber_files 13:48:03 INFO - Blob upload gear active. 13:48:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:48:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:48:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:48:04 INFO - (blobuploader) - INFO - Done attempting. 13:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:48:05 INFO - (blobuploader) - INFO - Done attempting. 13:48:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:48:05 INFO - Return code: 0 13:48:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:48:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:48:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24612ee3b4f5fa39d2a70dd14047728a2e539ffbd7dd692dfdae14c280194760dfb077260dcf1529c82ab5c88384150445403a46ac46ddd3066364c610a437af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33c0f9143fa93e965b668be315162d2e2161dca2a28012b5f892d9332790830058a682e3f0e404d3ae94aa45dff6ebb90865a6eae5907c275639fd5accee18d1"} 13:48:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:48:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:48:05 INFO - Contents: 13:48:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24612ee3b4f5fa39d2a70dd14047728a2e539ffbd7dd692dfdae14c280194760dfb077260dcf1529c82ab5c88384150445403a46ac46ddd3066364c610a437af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33c0f9143fa93e965b668be315162d2e2161dca2a28012b5f892d9332790830058a682e3f0e404d3ae94aa45dff6ebb90865a6eae5907c275639fd5accee18d1"} 13:48:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:48:05 INFO - Copying logs to upload dir... 13:48:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:48:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.785532 ========= master_lag: 3.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-05-06 13:48:08.649145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 13:48:08.654045) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370 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/24612ee3b4f5fa39d2a70dd14047728a2e539ffbd7dd692dfdae14c280194760dfb077260dcf1529c82ab5c88384150445403a46ac46ddd3066364c610a437af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33c0f9143fa93e965b668be315162d2e2161dca2a28012b5f892d9332790830058a682e3f0e404d3ae94aa45dff6ebb90865a6eae5907c275639fd5accee18d1"} build_url:https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/HiolmcohRr-9XFvLGXtl6w/artifacts/public/build/firefox-49.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/24612ee3b4f5fa39d2a70dd14047728a2e539ffbd7dd692dfdae14c280194760dfb077260dcf1529c82ab5c88384150445403a46ac46ddd3066364c610a437af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33c0f9143fa93e965b668be315162d2e2161dca2a28012b5f892d9332790830058a682e3f0e404d3ae94aa45dff6ebb90865a6eae5907c275639fd5accee18d1"}' ========= master_lag: 0.81 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 13:48:09.479724) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:48:09.480054) ========= 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=6d15e502d8e29d5d2676d664000001c3-1462566454.542956-1349487370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 13:48:09.499054) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 13:48:09.499337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 13:48:09.500422) ========= ========= Total master_lag: 4.59 =========