builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1468591063.53 results: success (0) buildid: 20160714105543 builduid: aa8f78178def422782ab8d456f54c137 revision: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.530945) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.531614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.532086) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.587797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.588132) ========= 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=af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 06:57:43-- 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% 227M=0s 2016-07-15 06:57:43 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192417 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.833049) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.833576) ========= 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=af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.100539 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:43.948316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 06:57:43.948907) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4087792d5fa736a0dc18df7aeefecf0a34d99f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0b4087792d5fa736a0dc18df7aeefecf0a34d99f --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=af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 06:57:43,946 truncating revision to first 12 chars 2016-07-15 06:57:43,946 Setting DEBUG logging. 2016-07-15 06:57:43,946 attempt 1/10 2016-07-15 06:57:43,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0b4087792d5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 06:57:44,606 unpacking tar archive at: mozilla-beta-0b4087792d5f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.007479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 06:57:44.970678) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:44.971046) ========= script_repo_revision: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:44.971436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:44.971697) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 06:57:44.982593) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-15 06:57:44.982970) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:45 INFO - MultiFileLogger online at 20160715 06:57:45 in /builds/slave/test 06:57:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:57:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:45 INFO - {'append_to_log': False, 06:57:45 INFO - 'base_work_dir': '/builds/slave/test', 06:57:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:57:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:45 INFO - 'branch': 'Mozilla-Beta', 06:57:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:45 INFO - 'config_files': ('talos/linux_config.py',), 06:57:45 INFO - 'default_actions': ('clobber', 06:57:45 INFO - 'read-buildbot-config', 06:57:45 INFO - 'download-and-extract', 06:57:45 INFO - 'populate-webroot', 06:57:45 INFO - 'create-virtualenv', 06:57:45 INFO - 'install', 06:57:45 INFO - 'run-tests'), 06:57:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:45 INFO - 'download_minidump_stackwalk': True, 06:57:45 INFO - 'download_symbols': 'ondemand', 06:57:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:45 INFO - 'installer_path': 'installer.exe', 06:57:45 INFO - 'log_level': 'info', 06:57:45 INFO - 'log_name': 'talos', 06:57:45 INFO - 'log_to_console': True, 06:57:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:45 INFO - 'opt_config_files': (), 06:57:45 INFO - 'pip_index': False, 06:57:45 INFO - 'sps_profile': False, 06:57:45 INFO - 'sps_profile_interval': 0, 06:57:45 INFO - 'suite': 'dromaeojs-e10s', 06:57:45 INFO - 'system_bits': '32', 06:57:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:45 INFO - 'title': 'talos-linux64-ix-020', 06:57:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:45 INFO - 'use_talos_json': True, 06:57:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:45 INFO - 'work_dir': 'build'} 06:57:45 INFO - ##### 06:57:45 INFO - ##### Running clobber step. 06:57:45 INFO - ##### 06:57:45 INFO - Running pre-action listener: _resource_record_pre_action 06:57:45 INFO - Running main action method: clobber 06:57:45 INFO - rmtree: /builds/slave/test/build 06:57:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:46 INFO - Running post-action listener: _resource_record_post_action 06:57:46 INFO - ##### 06:57:46 INFO - ##### Running read-buildbot-config step. 06:57:46 INFO - ##### 06:57:46 INFO - Running pre-action listener: _resource_record_pre_action 06:57:46 INFO - Running main action method: read_buildbot_config 06:57:46 INFO - Using buildbot properties: 06:57:46 INFO - { 06:57:46 INFO - "project": "", 06:57:46 INFO - "product": "firefox", 06:57:46 INFO - "script_repo_revision": "production", 06:57:46 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:57:46 INFO - "repository": "", 06:57:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:57:46 INFO - "buildid": "20160714105543", 06:57:46 INFO - "pgo_build": "True", 06:57:46 INFO - "basedir": "/builds/slave/test", 06:57:46 INFO - "buildnumber": 100, 06:57:46 INFO - "slavename": "talos-linux64-ix-020", 06:57:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:57:46 INFO - "platform": "ubuntu64_hw", 06:57:46 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:57:46 INFO - "branch": "mozilla-beta", 06:57:46 INFO - "repo_path": "releases/mozilla-beta", 06:57:46 INFO - "revision": "0b4087792d5fa736a0dc18df7aeefecf0a34d99f", 06:57:46 INFO - "stage_platform": "linux64-pgo", 06:57:46 INFO - "builduid": "aa8f78178def422782ab8d456f54c137", 06:57:46 INFO - "slavebuilddir": "test" 06:57:46 INFO - } 06:57:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 06:57:46 INFO - Running post-action listener: _resource_record_post_action 06:57:46 INFO - ##### 06:57:46 INFO - ##### Running download-and-extract step. 06:57:46 INFO - ##### 06:57:46 INFO - Running pre-action listener: _resource_record_pre_action 06:57:46 INFO - Running main action method: download_and_extract 06:57:46 INFO - mkdir: /builds/slave/test/build/tests 06:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:46 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:57:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:57:49 INFO - Downloaded 1327 bytes. 06:57:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 06:57:49 INFO - Using the following test package requirements: 06:57:49 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:57:49 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:49 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 06:57:49 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'jsshell-linux-x86_64.zip'], 06:57:49 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:49 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 06:57:49 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 06:57:49 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 06:57:49 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:49 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 06:57:49 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:49 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:49 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:50 INFO - Downloaded 24199700 bytes. 06:57:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:53 INFO - Return code: 0 06:57:53 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 06:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:57 INFO - Downloaded 24199700 bytes. 06:57:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:59 INFO - Return code: 0 06:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:59 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:57:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:57:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:57:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 06:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:58:00 INFO - Downloaded 10840145 bytes. 06:58:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:58:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:58:00 INFO - Return code: 0 06:58:00 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')]} 06:58:00 INFO - https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:58:02 INFO - Downloaded 56036779 bytes. 06:58:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:02 INFO - mkdir: /builds/slave/test/properties 06:58:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:02 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:02 INFO - Contents: 06:58:02 INFO - build_url:https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 06:58:02 INFO - Running post-action listener: _resource_record_post_action 06:58:02 INFO - Running post-action listener: set_extra_try_arguments 06:58:02 INFO - ##### 06:58:02 INFO - ##### Running populate-webroot step. 06:58:02 INFO - ##### 06:58:02 INFO - Running pre-action listener: _resource_record_pre_action 06:58:02 INFO - Running main action method: populate_webroot 06:58:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:02 INFO - '--tppagecycles', 06:58:02 INFO - '7'], 06:58:02 INFO - 'tests': ['tsvgm']}}, 06:58:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['damp', 'tps']}, 06:58:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'tests': ['damp', 'tps']}, 06:58:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['dromaeo_dom']}, 06:58:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['a11yr', 06:58:02 INFO - 'ts_paint', 06:58:02 INFO - 'tpaint', 06:58:02 INFO - 'sessionrestore', 06:58:02 INFO - 'sessionrestore_no_auto_restore', 06:58:02 INFO - 'tabpaint']}, 06:58:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:02 INFO - 'ts_paint', 06:58:02 INFO - 'tpaint', 06:58:02 INFO - 'sessionrestore', 06:58:02 INFO - 'sessionrestore_no_auto_restore', 06:58:02 INFO - 'tabpaint']}, 06:58:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:02 INFO - 'ts_paint', 06:58:02 INFO - 'tpaint', 06:58:02 INFO - 'sessionrestore', 06:58:02 INFO - 'sessionrestore_no_auto_restore', 06:58:02 INFO - 'tabpaint']}, 06:58:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:02 INFO - 'ts_paint', 06:58:02 INFO - 'tpaint', 06:58:02 INFO - 'sessionrestore', 06:58:02 INFO - 'sessionrestore_no_auto_restore', 06:58:02 INFO - 'tabpaint']}, 06:58:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['a11yr', 06:58:02 INFO - 'ts_paint', 06:58:02 INFO - 'tpaint', 06:58:02 INFO - 'sessionrestore', 06:58:02 INFO - 'sessionrestore_no_auto_restore', 06:58:02 INFO - 'tabpaint']}, 06:58:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['a11yr', 06:58:02 INFO - 'ts_paint', 06:58:02 INFO - 'tpaint', 06:58:02 INFO - 'sessionrestore', 06:58:02 INFO - 'sessionrestore_no_auto_restore', 06:58:02 INFO - 'tabpaint']}, 06:58:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['tsvgx', 06:58:02 INFO - 'tsvgr_opacity', 06:58:02 INFO - 'tart', 06:58:02 INFO - 'tscrollx', 06:58:02 INFO - 'cart']}, 06:58:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:02 INFO - 'tsvgr_opacity', 06:58:02 INFO - 'tart', 06:58:02 INFO - 'tscrollx', 06:58:02 INFO - 'cart']}, 06:58:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'talos_options': ['--disable-e10s'], 06:58:02 INFO - 'tests': ['tp5o']}, 06:58:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'tests': ['tp5o']}, 06:58:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'talos_options': ['--disable-e10s', 06:58:02 INFO - '--xperf_path', 06:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:02 INFO - 'tests': ['tp5n']}, 06:58:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:58:02 INFO - 'talos_options': ['--xperf_path', 06:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:02 INFO - 'tests': ['tp5n']}}, 06:58:02 INFO - 'talos.zip': {'path': '', 06:58:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:02 INFO - Running post-action listener: _resource_record_post_action 06:58:02 INFO - ##### 06:58:02 INFO - ##### Running create-virtualenv step. 06:58:02 INFO - ##### 06:58:02 INFO - Running pre-action listener: _resource_record_pre_action 06:58:02 INFO - Running main action method: create_virtualenv 06:58:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:02 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 06:58:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:03 INFO - Using real prefix '/usr' 06:58:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:07 INFO - Installing pip.................done. 06:58:07 INFO - Return code: 0 06:58:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:58:07 INFO - Using env: {'DISPLAY': ':0', 06:58:07 INFO - 'HOME': '/home/cltbld', 06:58:07 INFO - 'LANG': 'en_US.UTF-8', 06:58:07 INFO - 'LANGUAGE': 'en_US:en', 06:58:07 INFO - 'LOGNAME': 'cltbld', 06:58:07 INFO - 'MAIL': '/var/mail/cltbld', 06:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:07 INFO - 'MOZ_NO_REMOTE': '1', 06:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:07 INFO - 'NO_EM_RESTART': '1', 06:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:07 INFO - 'PWD': '/builds/slave/test', 06:58:07 INFO - 'SHELL': '/bin/bash', 06:58:07 INFO - 'SHLVL': '1', 06:58:07 INFO - 'TERM': 'linux', 06:58:07 INFO - 'TMOUT': '86400', 06:58:07 INFO - 'USER': 'cltbld', 06:58:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:07 INFO - '_': '/tools/buildbot/bin/python'} 06:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:08 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 06:58:08 INFO - Cleaning up... 06:58:08 INFO - Return code: 0 06:58:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:08 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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:08 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 06:58:08 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 06:58:08 INFO - Using env: {'DISPLAY': ':0', 06:58:08 INFO - 'HOME': '/home/cltbld', 06:58:08 INFO - 'LANG': 'en_US.UTF-8', 06:58:08 INFO - 'LANGUAGE': 'en_US:en', 06:58:08 INFO - 'LOGNAME': 'cltbld', 06:58:08 INFO - 'MAIL': '/var/mail/cltbld', 06:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:08 INFO - 'MOZ_NO_REMOTE': '1', 06:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:08 INFO - 'NO_EM_RESTART': '1', 06:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:08 INFO - 'PWD': '/builds/slave/test', 06:58:08 INFO - 'SHELL': '/bin/bash', 06:58:08 INFO - 'SHLVL': '1', 06:58:08 INFO - 'TERM': 'linux', 06:58:08 INFO - 'TMOUT': '86400', 06:58:08 INFO - 'USER': 'cltbld', 06:58:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:08 INFO - '_': '/tools/buildbot/bin/python'} 06:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:08 INFO - Downloading/unpacking psutil>=0.7.1 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:10 INFO - Installing collected packages: psutil 06:58:10 INFO - Running setup.py install for psutil 06:58:11 INFO - building 'psutil._psutil_linux' extension 06:58:11 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 06:58:13 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 06:58:14 INFO - building 'psutil._psutil_posix' extension 06:58:14 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 06:58:14 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 06:58:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:14 INFO - Successfully installed psutil 06:58:14 INFO - Cleaning up... 06:58:14 INFO - Return code: 0 06:58:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:58:14 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')]} 06:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:14 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')]} 06:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:14 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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:14 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 06:58:14 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 06:58:14 INFO - Using env: {'DISPLAY': ':0', 06:58:14 INFO - 'HOME': '/home/cltbld', 06:58:14 INFO - 'LANG': 'en_US.UTF-8', 06:58:14 INFO - 'LANGUAGE': 'en_US:en', 06:58:14 INFO - 'LOGNAME': 'cltbld', 06:58:14 INFO - 'MAIL': '/var/mail/cltbld', 06:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:14 INFO - 'MOZ_NO_REMOTE': '1', 06:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:14 INFO - 'NO_EM_RESTART': '1', 06:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:14 INFO - 'PWD': '/builds/slave/test', 06:58:14 INFO - 'SHELL': '/bin/bash', 06:58:14 INFO - 'SHLVL': '1', 06:58:14 INFO - 'TERM': 'linux', 06:58:14 INFO - 'TMOUT': '86400', 06:58:14 INFO - 'USER': 'cltbld', 06:58:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:14 INFO - '_': '/tools/buildbot/bin/python'} 06:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:58:16 INFO - Installing collected packages: mozsystemmonitor 06:58:16 INFO - Running setup.py install for mozsystemmonitor 06:58:16 INFO - Successfully installed mozsystemmonitor 06:58:16 INFO - Cleaning up... 06:58:16 INFO - Return code: 0 06:58:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:58:16 INFO - Using env: {'DISPLAY': ':0', 06:58:16 INFO - 'HOME': '/home/cltbld', 06:58:16 INFO - 'LANG': 'en_US.UTF-8', 06:58:16 INFO - 'LANGUAGE': 'en_US:en', 06:58:16 INFO - 'LOGNAME': 'cltbld', 06:58:16 INFO - 'MAIL': '/var/mail/cltbld', 06:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:16 INFO - 'MOZ_NO_REMOTE': '1', 06:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:16 INFO - 'NO_EM_RESTART': '1', 06:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:16 INFO - 'PWD': '/builds/slave/test', 06:58:16 INFO - 'SHELL': '/bin/bash', 06:58:16 INFO - 'SHLVL': '1', 06:58:16 INFO - 'TERM': 'linux', 06:58:16 INFO - 'TMOUT': '86400', 06:58:16 INFO - 'USER': 'cltbld', 06:58:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:16 INFO - '_': '/tools/buildbot/bin/python'} 06:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:16 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:18 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:19 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 06:58:19 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 06:58:19 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 06:58:19 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 06:58:19 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 06:58:19 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 06:58:19 INFO - Downloading docopt-0.6.1.tar.gz 06:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:19 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:19 INFO - Running setup.py install for blobuploader 06:58:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:19 INFO - Running setup.py install for requests 06:58:19 INFO - Running setup.py install for docopt 06:58:20 INFO - Successfully installed blobuploader requests docopt 06:58:20 INFO - Cleaning up... 06:58:20 INFO - Return code: 0 06:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:20 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')]} 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 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')]} 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:20 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 06:58:20 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 06:58:20 INFO - Using env: {'DISPLAY': ':0', 06:58:20 INFO - 'HOME': '/home/cltbld', 06:58:20 INFO - 'LANG': 'en_US.UTF-8', 06:58:20 INFO - 'LANGUAGE': 'en_US:en', 06:58:20 INFO - 'LOGNAME': 'cltbld', 06:58:20 INFO - 'MAIL': '/var/mail/cltbld', 06:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:20 INFO - 'MOZ_NO_REMOTE': '1', 06:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:20 INFO - 'NO_EM_RESTART': '1', 06:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:20 INFO - 'PWD': '/builds/slave/test', 06:58:20 INFO - 'SHELL': '/bin/bash', 06:58:20 INFO - 'SHLVL': '1', 06:58:20 INFO - 'TERM': 'linux', 06:58:20 INFO - 'TMOUT': '86400', 06:58:20 INFO - 'USER': 'cltbld', 06:58:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:20 INFO - '_': '/tools/buildbot/bin/python'} 06:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:20 INFO - Running setup.py (path:/tmp/pip-zhnRr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:20 INFO - Running setup.py (path:/tmp/pip-s2KB6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:20 INFO - Running setup.py (path:/tmp/pip-5xL6hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:20 INFO - Running setup.py (path:/tmp/pip-pX1lu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:20 INFO - Running setup.py (path:/tmp/pip-31mdHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:20 INFO - Running setup.py (path:/tmp/pip-mTlnDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:20 INFO - Running setup.py (path:/tmp/pip-fAAN3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:20 INFO - Running setup.py (path:/tmp/pip-Jie7pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:20 INFO - Running setup.py (path:/tmp/pip-DVoFGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:20 INFO - Running setup.py (path:/tmp/pip-zis1Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:21 INFO - Running setup.py (path:/tmp/pip-pkupif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:21 INFO - Running setup.py (path:/tmp/pip-tE3wNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:21 INFO - Running setup.py (path:/tmp/pip-HvGG6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:21 INFO - Running setup.py (path:/tmp/pip-ozbTWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:21 INFO - Running setup.py (path:/tmp/pip-Frt_RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:21 INFO - Running setup.py (path:/tmp/pip-q2sqTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:21 INFO - Running setup.py (path:/tmp/pip-U_SQ4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:21 INFO - Running setup.py install for manifestparser 06:58:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:21 INFO - Running setup.py install for mozcrash 06:58:21 INFO - Running setup.py install for mozdebug 06:58:21 INFO - Running setup.py install for mozdevice 06:58:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:58:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:21 INFO - Running setup.py install for mozfile 06:58:22 INFO - Running setup.py install for mozhttpd 06:58:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Running setup.py install for mozinfo 06:58:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Running setup.py install for mozInstall 06:58:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Running setup.py install for mozleak 06:58:22 INFO - Running setup.py install for mozlog 06:58:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Running setup.py install for moznetwork 06:58:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Running setup.py install for mozprocess 06:58:22 INFO - Running setup.py install for mozprofile 06:58:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Running setup.py install for mozrunner 06:58:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:22 INFO - Running setup.py install for mozscreenshot 06:58:23 INFO - Running setup.py install for moztest 06:58:23 INFO - Running setup.py install for mozversion 06:58:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:23 INFO - Cleaning up... 06:58:23 INFO - Return code: 0 06:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:23 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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:23 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 06:58:23 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 06:58:23 INFO - Using env: {'DISPLAY': ':0', 06:58:23 INFO - 'HOME': '/home/cltbld', 06:58:23 INFO - 'LANG': 'en_US.UTF-8', 06:58:23 INFO - 'LANGUAGE': 'en_US:en', 06:58:23 INFO - 'LOGNAME': 'cltbld', 06:58:23 INFO - 'MAIL': '/var/mail/cltbld', 06:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:23 INFO - 'MOZ_NO_REMOTE': '1', 06:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:23 INFO - 'NO_EM_RESTART': '1', 06:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:23 INFO - 'PWD': '/builds/slave/test', 06:58:23 INFO - 'SHELL': '/bin/bash', 06:58:23 INFO - 'SHLVL': '1', 06:58:23 INFO - 'TERM': 'linux', 06:58:23 INFO - 'TMOUT': '86400', 06:58:23 INFO - 'USER': 'cltbld', 06:58:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:23 INFO - '_': '/tools/buildbot/bin/python'} 06:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:23 INFO - Running setup.py (path:/tmp/pip-NJqy4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:23 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)) 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:23 INFO - Running setup.py (path:/tmp/pip-7Ru_ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:23 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)) 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:23 INFO - Running setup.py (path:/tmp/pip-YTk_HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:23 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)) 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:23 INFO - Running setup.py (path:/tmp/pip-0dNa49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:23 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)) 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:23 INFO - Running setup.py (path:/tmp/pip-NVdU7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:23 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)) 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:23 INFO - Running setup.py (path:/tmp/pip-eDdqZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:23 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)) 06:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:23 INFO - Running setup.py (path:/tmp/pip-sehxiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:24 INFO - Running setup.py (path:/tmp/pip-glPADl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:24 INFO - Running setup.py (path:/tmp/pip-zYcfrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:24 INFO - Running setup.py (path:/tmp/pip-3dMMls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:24 INFO - Running setup.py (path:/tmp/pip-ophokt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:24 INFO - Running setup.py (path:/tmp/pip-rGSGee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:24 INFO - Running setup.py (path:/tmp/pip-BLywqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:24 INFO - Running setup.py (path:/tmp/pip-0KGBqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:24 INFO - Running setup.py (path:/tmp/pip-FmKyJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:24 INFO - Running setup.py (path:/tmp/pip-wzRttj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:24 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)) 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:24 INFO - Running setup.py (path:/tmp/pip-HCGOWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:24 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)) 06:58:24 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)) 06:58:24 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)) 06:58:24 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)) 06:58:24 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)) 06:58:24 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)) 06:58:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:26 INFO - Downloading blessings-1.6.tar.gz 06:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:26 INFO - Installing collected packages: blessings 06:58:26 INFO - Running setup.py install for blessings 06:58:26 INFO - Successfully installed blessings 06:58:26 INFO - Cleaning up... 06:58:26 INFO - Return code: 0 06:58:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:27 INFO - Reading from file tmpfile_stdout 06:58:27 INFO - Current package versions: 06:58:27 INFO - argparse == 1.2.1 06:58:27 INFO - blessings == 1.6 06:58:27 INFO - blobuploader == 1.2.4 06:58:27 INFO - docopt == 0.6.1 06:58:27 INFO - manifestparser == 1.1 06:58:27 INFO - mozInstall == 1.12 06:58:27 INFO - mozcrash == 0.17 06:58:27 INFO - mozdebug == 0.1 06:58:27 INFO - mozdevice == 0.48 06:58:27 INFO - mozfile == 1.2 06:58:27 INFO - mozhttpd == 0.7 06:58:27 INFO - mozinfo == 0.9 06:58:27 INFO - mozleak == 0.1 06:58:27 INFO - mozlog == 3.1 06:58:27 INFO - moznetwork == 0.27 06:58:27 INFO - mozprocess == 0.22 06:58:27 INFO - mozprofile == 0.28 06:58:27 INFO - mozrunner == 6.11 06:58:27 INFO - mozscreenshot == 0.1 06:58:27 INFO - mozsystemmonitor == 0.0 06:58:27 INFO - moztest == 0.7 06:58:27 INFO - mozversion == 1.4 06:58:27 INFO - psutil == 3.1.1 06:58:27 INFO - requests == 1.2.3 06:58:27 INFO - wsgiref == 0.1.2 06:58:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:27 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')]} 06:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:27 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')]} 06:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:27 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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:27 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 06:58:27 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 06:58:27 INFO - Using env: {'DISPLAY': ':0', 06:58:27 INFO - 'HOME': '/home/cltbld', 06:58:27 INFO - 'LANG': 'en_US.UTF-8', 06:58:27 INFO - 'LANGUAGE': 'en_US:en', 06:58:27 INFO - 'LOGNAME': 'cltbld', 06:58:27 INFO - 'MAIL': '/var/mail/cltbld', 06:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:27 INFO - 'MOZ_NO_REMOTE': '1', 06:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:27 INFO - 'NO_EM_RESTART': '1', 06:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:27 INFO - 'PWD': '/builds/slave/test', 06:58:27 INFO - 'SHELL': '/bin/bash', 06:58:27 INFO - 'SHLVL': '1', 06:58:27 INFO - 'TERM': 'linux', 06:58:27 INFO - 'TMOUT': '86400', 06:58:27 INFO - 'USER': 'cltbld', 06:58:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:27 INFO - '_': '/tools/buildbot/bin/python'} 06:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 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)) 06:58:27 INFO - Cleaning up... 06:58:27 INFO - Return code: 0 06:58:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58:27 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')]} 06:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:27 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')]} 06:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:27 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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:27 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 06:58:27 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 06:58:27 INFO - Using env: {'DISPLAY': ':0', 06:58:27 INFO - 'HOME': '/home/cltbld', 06:58:27 INFO - 'LANG': 'en_US.UTF-8', 06:58:27 INFO - 'LANGUAGE': 'en_US:en', 06:58:27 INFO - 'LOGNAME': 'cltbld', 06:58:27 INFO - 'MAIL': '/var/mail/cltbld', 06:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:27 INFO - 'MOZ_NO_REMOTE': '1', 06:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:27 INFO - 'NO_EM_RESTART': '1', 06:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:27 INFO - 'PWD': '/builds/slave/test', 06:58:27 INFO - 'SHELL': '/bin/bash', 06:58:27 INFO - 'SHLVL': '1', 06:58:27 INFO - 'TERM': 'linux', 06:58:27 INFO - 'TMOUT': '86400', 06:58:27 INFO - 'USER': 'cltbld', 06:58:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:27 INFO - '_': '/tools/buildbot/bin/python'} 06:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:27 INFO - Downloading/unpacking jsonschema 06:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:29 INFO - Downloading/unpacking functools32 (from jsonschema) 06:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:29 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:29 INFO - warning: no files found matching '*.txt' 06:58:29 INFO - no previously-included directories found matching 'build' 06:58:29 INFO - no previously-included directories found matching 'dist' 06:58:29 INFO - no previously-included directories found matching '.git*' 06:58:29 INFO - Installing collected packages: jsonschema, functools32 06:58:29 INFO - Running setup.py install for functools32 06:58:30 INFO - warning: no files found matching '*.txt' 06:58:30 INFO - no previously-included directories found matching 'build' 06:58:30 INFO - no previously-included directories found matching 'dist' 06:58:30 INFO - no previously-included directories found matching '.git*' 06:58:30 INFO - Successfully installed jsonschema functools32 06:58:30 INFO - Cleaning up... 06:58:30 INFO - Return code: 0 06:58:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:58:30 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')]} 06:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:30 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')]} 06:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:30 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 0x7f126ec2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', '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 06:58:30 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 06:58:30 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 06:58:30 INFO - Using env: {'DISPLAY': ':0', 06:58:30 INFO - 'HOME': '/home/cltbld', 06:58:30 INFO - 'LANG': 'en_US.UTF-8', 06:58:30 INFO - 'LANGUAGE': 'en_US:en', 06:58:30 INFO - 'LOGNAME': 'cltbld', 06:58:30 INFO - 'MAIL': '/var/mail/cltbld', 06:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:30 INFO - 'MOZ_NO_REMOTE': '1', 06:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:30 INFO - 'NO_EM_RESTART': '1', 06:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:30 INFO - 'PWD': '/builds/slave/test', 06:58:30 INFO - 'SHELL': '/bin/bash', 06:58:30 INFO - 'SHLVL': '1', 06:58:30 INFO - 'TERM': 'linux', 06:58:30 INFO - 'TMOUT': '86400', 06:58:30 INFO - 'USER': 'cltbld', 06:58:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:30 INFO - '_': '/tools/buildbot/bin/python'} 06:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:30 INFO - Downloading/unpacking flake8 06:58:30 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 06:58:30 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 06:58:30 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 06:58:30 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 06:58:30 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 06:58:30 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 06:58:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:58:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:58:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 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 06:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:32 INFO - no previously-included directories found matching 'docs/_build' 06:58:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:58:33 INFO - Running setup.py install for pep8 06:58:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:58:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:58:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:58:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:58:33 INFO - no previously-included directories found matching 'docs/_build' 06:58:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:58:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:58:33 INFO - Cleaning up... 06:58:33 INFO - Return code: 0 06:58:33 INFO - Running post-action listener: _resource_record_post_action 06:58:33 INFO - Running post-action listener: _start_resource_monitoring 06:58:33 INFO - Starting resource monitoring. 06:58:33 INFO - ##### 06:58:33 INFO - ##### Running install step. 06:58:33 INFO - ##### 06:58:33 INFO - Running pre-action listener: _resource_record_pre_action 06:58:33 INFO - Running main action method: install 06:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:33 INFO - Reading from file tmpfile_stdout 06:58:33 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:33 INFO - Reading from file tmpfile_stdout 06:58:33 INFO - Output received: 06:58:33 INFO - Usage: mozinstall [options] installer 06:58:33 INFO - Options: 06:58:33 INFO - -h, --help show this help message and exit 06:58:33 INFO - -d DEST, --destination=DEST 06:58:33 INFO - Directory to install application into. [default: 06:58:33 INFO - "/builds/slave/test"] 06:58:33 INFO - --app=APP Application being installed. [default: firefox] 06:58:33 INFO - mkdir: /builds/slave/test/build/application 06:58:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:58:46 INFO - Reading from file tmpfile_stdout 06:58:46 INFO - Output received: 06:58:46 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:46 INFO - Running post-action listener: _resource_record_post_action 06:58:46 INFO - ##### 06:58:46 INFO - ##### Running run-tests step. 06:58:46 INFO - ##### 06:58:46 INFO - Running pre-action listener: _resource_record_pre_action 06:58:46 INFO - Running main action method: run_tests 06:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:46 INFO - Python 2.7.3 06:58:46 INFO - Return code: 0 06:58:46 INFO - grabbing minidump binary from tooltool 06:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:46 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 0x15a6410>, '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 0x15a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:46 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 06:58:46 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 06:58:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:46 INFO - Return code: 0 06:58:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:58:47 INFO - Return code: 0 06:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 06:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 06:58:47 INFO - Using env: {'DISPLAY': ':0', 06:58:47 INFO - 'HOME': '/home/cltbld', 06:58:47 INFO - 'LANG': 'en_US.UTF-8', 06:58:47 INFO - 'LANGUAGE': 'en_US:en', 06:58:47 INFO - 'LOGNAME': 'cltbld', 06:58:47 INFO - 'MAIL': '/var/mail/cltbld', 06:58:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:47 INFO - 'MOZ_NO_REMOTE': '1', 06:58:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:47 INFO - 'NO_EM_RESTART': '1', 06:58:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:47 INFO - 'PWD': '/builds/slave/test', 06:58:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:47 INFO - 'SHELL': '/bin/bash', 06:58:47 INFO - 'SHLVL': '1', 06:58:47 INFO - 'TERM': 'linux', 06:58:47 INFO - 'TMOUT': '86400', 06:58:47 INFO - 'USER': 'cltbld', 06:58:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369', 06:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:47 INFO - '_': '/tools/buildbot/bin/python'} 06:58:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 06:58:48 INFO - mozversion application_buildid: 20160714105543 06:58:48 INFO - mozversion application_changeset: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f 06:58:48 INFO - mozversion application_display_name: Firefox 06:58:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:48 INFO - mozversion application_name: Firefox 06:58:48 INFO - mozversion application_remotingname: firefox 06:58:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:58:48 INFO - mozversion application_vendor: Mozilla 06:58:48 INFO - mozversion application_version: 48.0 06:58:48 INFO - mozversion platform_buildid: 20160714105543 06:58:48 INFO - mozversion platform_changeset: 0b4087792d5fa736a0dc18df7aeefecf0a34d99f 06:58:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:58:48 INFO - mozversion platform_version: 48.0 06:58:48 INFO - using testdate: 1468591128 06:58:48 INFO - actual date: 1468591128 06:58:48 INFO - starting webserver on 'localhost:56109' 06:58:48 INFO - SUITE-START | Running 2 tests 06:58:48 INFO - TEST-START | dromaeo_css 06:58:48 INFO - operating with platform_type : linux_ 06:58:48 INFO - Initialising browser for dromaeo_css test... 06:58:48 INFO - TEST-INFO | started process 3308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1zA6F7/profile http://localhost:56109/getInfo.html) 06:58:52 INFO - PROCESS | 3308 | 06:58:52 INFO - PROCESS | 3308 | (process:3387): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:58:53 INFO - PROCESS | 3308 | __metrics Screen width/height:1600/1200 06:58:53 INFO - PROCESS | 3308 | colorDepth:24 06:58:53 INFO - PROCESS | 3308 | Browser inner width/height: 1024/697 06:58:53 INFO - PROCESS | 3308 | __metrics 06:58:54 ERROR - PROCESS | 3308 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:58:55 INFO - TEST-INFO | 3308: exit 0 06:58:55 INFO - Browser initialized. 06:58:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:55 INFO - TEST-INFO | started process 3438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1zA6F7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:56 INFO - PROCESS | 3438 | 06:58:56 INFO - PROCESS | 3438 | (process:3504): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:59:06 INFO - PROCESS | 3438 | RSS: Main: 150507520 06:59:06 INFO - PROCESS | 3438 | 06:59:56 INFO - PROCESS | 3438 | 1468591196477 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] 07:02:03 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:56109/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56109/tests/dromaeo/cssquery-ext.html) 07:02:04 INFO - PROCESS | 3438 | RSS: Main: 154513408 07:02:04 INFO - PROCESS | 3438 | 07:05:06 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:56109/tests/dromaeo/cssquery-ext.html (next: http://localhost:56109/tests/dromaeo/cssquery-jquery.html) 07:05:07 INFO - PROCESS | 3438 | RSS: Main: 152485888 07:05:07 INFO - PROCESS | 3438 | 07:08:08 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:56109/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56109/tests/dromaeo/cssquery-mootools.html) 07:08:09 INFO - PROCESS | 3438 | RSS: Main: 151744512 07:08:09 INFO - PROCESS | 3438 | 07:11:11 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:56109/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56109/tests/dromaeo/cssquery-prototype.html) 07:11:11 INFO - PROCESS | 3438 | RSS: Main: 153243648 07:11:11 INFO - PROCESS | 3438 | 07:14:13 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:56109/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56109/tests/dromaeo/cssquery-yui.html) 07:14:14 INFO - PROCESS | 3438 | RSS: Main: 151519232 07:14:14 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | Cycle 1(1): loaded http://localhost:56109/tests/dromaeo/cssquery-yui.html (next: http://localhost:56109/tests/dromaeo/cssquery-dojo.html) 07:17:16 INFO - PROCESS | 3438 | RSS: Main: 155242496 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | __start_tp_report 07:17:16 INFO - PROCESS | 3438 | _x_x_mozilla_page_load 07:17:16 INFO - PROCESS | 3438 | _x_x_mozilla_page_load_details 07:17:16 INFO - PROCESS | 3438 | |i|pagename|runs| 07:17:16 INFO - PROCESS | 3438 | |0;dojo.html;3309.718673912717;3344.799312041276;3350.112220261631;3368.814715190665;3389.6610338966107;5516.117421212607;5521.420250873661;5528.9999999999945;5556;5582.776688932443;5497.505224529791;5510.063289240828;5527.447255274471;5537.916931246034;5554.028045092113;4999.275105109766;5061.240813877929;5069.847904562869;5081.161608334621;5090.567301779353;5002.174641184219;5044.243363495469;5050.090983622947;5054.898902021957;5104.591632669378;5035.924461133086;5065.214891691794;5072.036313100518;5089.185730283156;5091.0581542414775;5065.848024559269;5070.29015937769;5079.79680812767;5084;5104.5405913467785;4961.801527938878;4971.552560269557;4981.501849815026;4987.925181122286;5019.347484826949;5308.628396012281;5327.520523152934;5334.146536554133;5341.1187154119525;5352.2239275305255;5797.869415463986;5805.854853628651;5809.419058094199;5812.709364531799;5817.476427121579;5854.063349864044;5924.318703349127;5961.105834124873;5989.670568118751;6014.578979471439;5509.862253443696;5516.779328826842;5518.310211223597;5524.696141712204;5525.806596769134;5921.259842519685;5935.287765468085;5938.257717785277;5945.910811337833;5977.850553736104;5746.597738158289;5764.250647415893;5790.420957904176;5796.594238403356;5828.300603927556;5860.794872179454;5861;5861.062230043172;5862.912056319158;5863.589548731633;5733.512651424676;5774;5823.242978412779;5829.300483941955;5851.590388672837;5849.766009359663;5854.765809367663;5860.267466566679;5866.677332746654;5879.52963762898;4489;4504.797284122223;4513.390692256569;4516.954830451719;4537.115262523842;3995.260876737813;4030.717849750489;4045.8786236412957;4051.372037334218;4067.5322337930925;5534.889302213933;5593.804216852391;5595.664260144405;5618.241537392481;5628.127640215773;5918.201042859245;5921.496672782776;5925.585209035326;5926.2295901532525;5937.109433584997;5407.783688652488;5535;5629.043062679354;5639.520640745583;5723.141528770718;5126.871828204325;5130.230465430215;5132.743362831843;5139;5144.61415393847;6134.539909506716;6188.040853667689;6205.565610407228;6212.627242365473;6224.9377506224355;5858.941410585925;5960.493358064613;5988.221531200916;5988.341282459013;5995.46040856325;6120.846978825565;6195.81412557624;6196.907046394398;6206.131141640084;6210.130581718653;5702;5724.57065720081;5831.446012628793;5838.065909454467;5845.736941837713;5894.852628684317;5913.733881975408;5923.229980102559;5941.762329506944;5970.850728731816;5759.337676167127;5760.020796464695;5761.740721667451;5766.106253530709;5775.5090817281;5666.320041595035;5705.914411283917;5709.571782116275;5746.856328591819;5787.016207244695;5634.971825140848;5655.858603534944;5655.971720141373;5656.717164141859;5661.858453538694;5697.145428185805;5721.656700597978;5722;5770.105633626795;5773.595848290747;5517.806876759294;5628.690422026828;5642.605017648725;5650.604457687922;5733.397993210653 07:17:16 INFO - PROCESS | 3438 | |1;ext.html;661.6030381770938;679.8436359637286;681.7477533312674;727.487121579287;740.7925780781383;31382;39962;40476;40720.59279407205;40831.59168408315;42884;43886.78056609721;44025.339619905724;44081.77959110208;44233.7788311058;8574.871376929352;8767.254783343391;8793.340499462534;8817.721430392588;8824.823503529926;8773.956130219372;8841.425307355;8886.955565222164;8904.510251936174;8909.109089091104;9151.267898568098;9245.491497967609;9246.583903724348;9251.583678734472;9258.351915365927;9129.634814607407;9139.405938614002;9199.586018629177;9203.723888283363;9210.76973075675;9052.59263333145;9174.174324310845;9174.174324310845;9180.44917304964;9184.8622270666;44182;44733.10533789306;44818.55181448209;44902.32646510305;44920;3733.831977561016;3880.5925377835483;3903.6877049835944;3915.353966595508;3968.5436174839974;33982.32035359279;34117.31765364679;34413.82793086043;34735.65264347349;34748.47877281843;4504;4629.884252893671;4642.605378542828;4676.953230467686;4693.718376897397;314510;316241;318382;319872;320220;39481.40777888276;62231.6888415555;62772;62783.37216627866;62837.37162628315;38200.426993595116;38318.80840595779;38331.616683832806;38346.42480362797;38355.232895341935;16498.505044848673;16714.08072555997;16716.58208544796;16733.079680617684;16759.581010474834;14785.186814725294;14833.851661483248;14884.255787210595;14973.625659358386;14997.400103995937;9188.908110918805;9194.816103678022;9282.071792820663;9302.441853488812;9304.441733495876;3476.878309259164;3530.947035794465;3536;3549.9645003549635;3604.0809593554;1126.9463052046362;1186.2822992089662;1229.624964385853;1239.9070069744805;1251.130464327302;32490.050596964258;32613.836930815192;32894.67105328964;33146.33707325888;33415.66584334174;1233.7532493501335;1236.9690757731128;1237.622525129826;1249.256692268099;1257.390165769601;16903.323867045427;17104.973701577946;17483.825161748475;17540.035298058476;17568.2094305754;529421;535704;610016;619759;959678;56535.71732141313;57622;57756;57799.711001444724;58177.418225818044;1549.3028137338242;1557.096883807389;1562.4687606213715;1569.6389830339085;1632.9712281262966;30825.845870770503;31183;31420;31794.364112718078;32238.516422253215;54939.45060549343;55495.44504554903;55577;55580.44419555915;55709;456112;457011;459692;461508;463431;30949;31737.20656983594;31801.5229771549;31928.36143277168;31971.36057278888;50433.24350134678;51274;52544.21183682324;52557.47442525679;52661;38561.614383855805;38607.8417647471;43023.78488107539;44700.98845551893;44862.3270650947;38417.4237386445;38681.613183868925;38997.22005559816;39030.6096939027;39612.80193599014;41813.90930453526;42468.78765606152;42686.5731342695;42732.35901461543;42845.35731963961;35701.64298357087;36767.26465470622;37190.25619487649;37720.811395942845;37808;28801.855990719912;29371.57721114087;29378.412431751673;29438.264043399085;29528 07:17:16 INFO - PROCESS | 3438 | |2;jquery.html;412.9958700412996;415.26498098365875;418.4978026368359;421.7090207756648;431.6719293337063;18711.71932421013;19360.612787744256;19409.902950485244;19921.701174482394;21280.46798830026;19957.800421995777;20340.491487712814;20498;20557.588848223026;20578.279760208396;5715.99999999999;5750;5933.317668468138;5946.197263369433;5986.2517185351835;5820.621659592134;5883;5885.588008839383;5887.175795388649;5932.555058370618;5624.521915637176;5842.415758424166;5848.41515848416;5864.501517371007;5872.265966754156;5756.165356023374;5762.74067666956;5771.451712087345;5799.420057994209;5829.300483941933;5184.377874655065;5200.271961925334;5207.6354655174155;5224.39919409269;5232.319798426181;23341.299761007198;23889.52220955571;24139.63790543143;24371;24438.266851994467;2621.829581077243;2633.47330533894;2884.120343295294;3050.23744063984;3136.8431578420987;14388.064775789644;14898.776518352233;15061.397544098332;15163.545093647208;15420.691586168326;2058.5162486815584;2082.531430428157;2184.1809321504434;2271.5911135995516;2296.276672848064;78787.21212787856;79683;81041.59479202566;81195.18804811935;81319;11662.825057624143;11676.941615292038;11740.70648233801;11837.348945808064;11935.104867135;16449.342026318813;16489.6702065958;16554.58613534647;16562.337506499603;16578.253978570992;8853;8899.15458031486;8957.14907083826;9006.054364291786;9139.177474027236;8622.396432249809;8684.60919258635;8764.824703506021;8820.647174112964;8825.91174088251;4908.92636610444;5023.246513023076;5062.645614806928;5079.466656001141;5138.254953031789;2061.443410279246;2109.831213502916;2115.3019503563787;2139.3261122746285;2167.5014746608053;474.09447954406915;1053.257453495284;1117.921745477825;1123.842662027317;1215.4057662037512;11184.776304473866;11740.354280514483;11804.58683946075;11979.880201198052;12028.699282518008;486.5890700797261;497.562145312123;509.74003258338513;515.6570880364516;517.2086707337779;6488.610683359014;6585.5719378240265;6585.9012114818315;6594.109795177686;6599.373059559334;556207;570685;585110;590726;593111;76320.23679763131;90284;91582.54208728914;98546.50726746464;106116.46941765396;1122.5117074072805;1126.1328776841785;1129.5651174297955;1168.1005625668188;1168.193946177135;17341.219645115747;18111.728324074887;18489.81510184881;18617.976011319508;18809.153588088295;26841.865790670923;39723.80138099291;41125;41726.61870503645;41790.95522611959;61034;61141.694291528256;61357.38642613517;61571.692141539;62151.37848621456;8858.601362938554;8870.689525866565;8940.689147005052;9031.232345250464;9051.954740226256;11891.405429728306;12360.320182390054;12424.316662583644;12665.493380264686;12734.808977865525;10840.45797710127;11040.558377664804;11174.49714762854;11236.94381528087;11402.20184587071;10804.621838235624;11128.165387596124;11365.090792736726;11380.317180969168;11758.176927615326;11671.59149429766;11736.178467507192;11901;12004.579839705568;12136.453859576517;8938.195562399154;8939.284857211538;9030.413023153475;9108.407953483002;9139.954300228455;8678.479291242546;10471.63349282802;10876.836847447137;10904.12766978624;10975.835362469728 07:17:16 INFO - PROCESS | 3438 | |3;mootools.html;1518.7949626800382;1548.512218651125;1718.9914050429745;1834.1562881074706;1844.3636945253884;7161.89257161143;8071.878921816177;8216.630251638675;8479.872801907968;8555.871661925075;8212.425130240885;8350.039745429278;8378.706745263917;8418.873716894252;8435.957820210906;2388.295452841407;2412.9034838606435;2416.299273210767;2417.5648383291;2419.11702228687;2383.892724827378;2415.698037745282;2423.7939775119135;2449.5590793657134;2450.5588993981078;2428.5871401861637;2449.3998970252314;2457.7910877575428;2469;2470.2712699753524;2430.793382562484;2449.9265022049367;2454.963175552377;2469.9012039518398;2471.666325046123;2420.225527831095;2436.671049408325;2441.7558244175616;2450.546648869965;2464.8521088734733;8324.125966773463;8395.95802020986;8401.789955251168;8411.95794021032;8417.326613870875;5341.866453338659;5377.220303056074;5397.487238712316;5436.673799571999;5462.0987537056335;3564.2336897567147;3586.228960773446;3590.4434812604086;3601.94597081044;3698.0754811297174;1192.296545038423;1288.1948782011243;1311.5016293808387;1328.701042265492;2163.653815389546;11243.381614011227;11435;11437.59968401102;11454.25547339412;11866.52533898643;4506.909861802811;4569.794359253841;4574.771261436915;4606.539346065367;4608.6082682971655;9361.578728957076;9369.531523423802;9378.718638440858;9380.296477764196;9422.481763502936;5294.444083371268;5328.49379308965;5338.3593968724;5341.0653135701095;5344.091504444254;4882.096812089775;5002.474740152305;5003.849884503398;5011.824586139468;5057.72182529957;3896.7272290939363;3967.563568007517;3981.144054028398;4036.0918793271867;4036.8990775230855;1239.4608345369793;1247.4324182496941;1249.6001279590444;1251.205484517338;1258.7293731847515;881.7751473374249;910.253592054509;998.8651532043226;1000.1998401278947;1003.4430890855646;5982.49148822355;5990.191324171268;6067.423594758491;6077.908831367533;6100.450959413585;442.6945407668698;444.5554445554446;447.4027173723116;447.8768338706882;456.4294631710362;4011.176406248495;4031.254217969685;4081.7142800003717;4086.6730661547003;4158.6673066155245;10295.176385889112;10775.676729698122;10778.676639700821;10782.892171078345;10787.83818242727;9943.353682010791;10068.446235456973;10083.243756718275;10242.743931401774;10644.946775266075;7993.600319983978;8136.389770767216;8169.63236654352;8173.918260817316;8174.836503269901;5650.915236271541;5826.73779679907;5827.329857066492;5844.795432159854;5866.5893387462465;9168.954155229449;9292.16370526656;9297.581608827755;9395.2953528487;9469.384490008128;9142.22291105237;9227.169554740105;9375.671851485165;9407.4825884577;9644.083812037845;6579.407853293226;7354.191038985814;7541.472096953161;7587.165411804807;7727.381809455343;8097.716579919675;8150.98112735908;8160.020797504338;8174.182581741778;8206.097329293892;7269.709211631475;7347.963260183665;7497.587632680255;7553.471257011956;7678.1170165431695;7331.376832969044;7370.041894553674;7396.149442814145;7459.2540745927145;7463.141738700119;6709.228438729609;6713;6714.3957043866285;6718.361755633207;6721.193456785217;4762.499937506512;4901.50984901507;4903.26451032348;5018.322526458881;5242.18746094356;5112.897742045213;5182.404023537341;5192;5213.973930130325;5315.255864178941 07:17:16 INFO - PROCESS | 3438 | |4;prototype.html;343.142144638404;353.4397979202963;354.33208402161927;357.92483578448525;360.17519879476004;6381.936180638192;6519.967400162993;6550.115734375858;6609.636469994149;6624.205095388554;6553.606783592988;6590.275069742324;6590.60456372618;6593.109930159427;6596.868062638744;4964.602831773458;4966.428860681014;4967.552920237178;4969.776360063805;4974;4979.626528010395;4980.352554167971;4981.5516603505675;4982.800687972477;4988.65079444439;4942;4946.802127914879;4947.653664243504;4950.232713929328;4954.826581069663;4810.278458231258;4946;4948.134076536628;4953.10844048073;4954.925676114844;4303.849365272201;4317.201317756225;4323.048929235563;4327.394164816928;4333.804978775963;6212.65830379329;6235.282942461629;6236.189295391616;6296.653684047421;6310.432061114476;5759.1937128802;5806.1000544915605;5809.3609702932645;5810.041343178371;5824.359320474744;6859.725610975555;6897.068895699117;6900.930990690079;6902.792916212471;6912.516123871331;4709.929351059737;4856.17445034345;4860.781264843091;4865.148598995162;4867.221244600847;7087.1495420549345;7100.112485939258;7135.143782746104;7156.821079473003;7157.89263161053;4933.950660493421;4947.802087916443;4953.678010929278;4963.975180124076;4966.304717339575;5025.095482813055;5031.245313202976;5032;5034.672746271481;5035.370578677665;5778.248827652378;5779.797707080316;5782.421757824268;5783.537317014629;5792.623479473821;6816.216135144522;6949.30506949301;6953.930460695429;6956.373926346653;6958.304169583002;1752.2903224194222;1761.2250609731677;1774.5829730013436;1776.4581802550088;1780.2167046499499;1150;1153.7173392518887;1169.351010189336;1185.4132204558798;1189.4409627475072;6626.469882409396;6651.700673469705;6654.633995130217;6657.23441804189;6667.63328016954;7045.365917067488;7055;7062.364387205176;7064.964675176694;7067.858642827115;6626.138601981712;6628.933710662928;6640.169978752656;6642.86714265712;6646.036324732887;3801.5628202756484;3815.141593141521;3839.9616003839606;3840.2703486338064;3842.366009608383;7281.344678978918;7461.515001524884;7461.664225109775;7562.054743157106;7589.658465369072;7162.4986250962975;7192.28077192287;7193.856122877618;7197.172325182566;7207.89188162178;7381.741639042608;7386.187519372865;7393.445491588045;7403.111626604842;7445.516041457397;6908.44732421395;7016.473764467787;7036.190838053484;7036.366726994595;7051.717931282691;6895.620740859301;6918.757843475454;6931.376176143969;6934.93065069363;6939.618320992394;7385.113786345673;7403.814904627212;7415.740449084256;7429.628518574158;7456.478046536908;4955.281484184845;4955.900881982412;4960.032793605356;4962.131626965339;4970.403551573834;7025.68384422692;7055;7065;7068.68190931399;7075.575465472089;6754.5609535380045;6989.965050174716;7003;7004.719811207495;7008.5094043416475;6859.965700171467;6936.375726184668;6950.721971121098;6957.234704182637;6961.8955715665315;6860.073890024983;6863.38229559342;6875.48433867452;6924.965375173092;6938.687759050956;6883.139607549057;6966.338197871194;7020.227774944854;7027.543209691354;7063.187733410724;6654.367835055662;6845.760398386033;6851.725930962905;6852.554583952027;6857.83416819132 07:17:16 INFO - PROCESS | 3438 | |5;yui.html;830.9210624990627;870.4777133719765;909.1635695160454;915.2906497464464;931.590100355843;13601.591952241437;14842.703145937088;15062.698746025073;15080.472183473581;15125.47060852869;14158.079724817906;14173.92913035436;14252.928735356334;14260.928695356535;14314.069585476936;863.9827203455943;877.1623099939543;878.6748902905933;883.7569668341225;894.5706061090681;870.8563087090622;876.5529579914257;879.134052957836;880.4717169698193;881.1100788203928;933.5985526223722;936.5644975086583;939.5724945149974;940.5297351324338;942.2697409507653;931.1340453378356;931.2270815223349;931.483026920059;932.5150921520805;934.6541779541545;685.5920727167328;686.5468790598181;686.615495322616;686.8626274745071;689.3554526517672;13845.930770346184;14130.50543230982;14139.646508837259;14141.222232777192;14143.080699754482;13982.72034559303;14042.438302467888;14081;14164.57506274803;14247.145171289652;12064.638060858188;12128.969037631812;12133.090018248668;12136.453859576251;12321.815172772416;4048.736832105933;4068.1253530491085;4073.572274911151;4084.7549147050977;4105.220008198433;54540;54925.725371373286;55345.72327138379;55399.44600553983;55418.44581554214;10918;10929.398883061349;11016.614418495314;11085.22403431752;11145.387003714712;19984.800151998585;19991.800081999285;20006.299779507648;20030.098645560985;20053.699194512094;8327.375446841512;8498.150184981452;8540.413744915553;8742.431741936754;8750.34372422071;4960.330355402047;5039.899202015939;5123.154679477919;5138.486151384832;5214.009338225801;3553.9822300888845;3605.405108157177;3617.8010209438207;3618.9638103619154;3627;662.6392484798007;673.6093066021696;675.5946432140775;676.0501495398972;677.3463607618671;789.3527307607707;826.5371392020488;831.4304701279643;838.266516797802;861.3841103610948;9613.663521776703;10086;10099.242556808269;10311;10349.896501035044;675.2403546010738;683.0846665468297;683.5010442377093;744.5793126883293;872.6858331000834;4716.679329787665;4726.480087190406;4813.687110337817;4987.476314986947;4988.052270068675;60748.39251607516;61647.38352616506;61984;62074.379256207765;62524.374756251855;55410.445895541336;55750.72124639351;55942.44057559453;56386;56892.71553642288;47489.76255118702;47713;52634.21048684273;54529.1820622683;62798;9718.271129665161;10051.095401413908;10085.546150423103;10201.693949181536;10423.478826058818;39260;39662;40304.1939161221;40358.79820600878;40866.79566602148;47708;50933.74533127311;51723.74138129285;51915;52211.47788522218;13146.408411621309;13493;13656;13721.45114195421;13759.96800240006;14358.56924292273;14401.711965760416;14498.275086245434;14790.186539739987;15532.68934621324;13315.533956311483;13606.659833504242;13645.454181832616;13655;13720.519781807589;12948.761856544976;13274.734505309647;13322.733545329233;13374.197548147142;13407.061505694508;13256.734865302833;13621.25083120438;13657.931710341385;13983.790243146157;14228;10706.839397409201;10742.462876856282;10900.890991089987;10982.395968221825;11042.668719938414;10693.686360481252;10698.73253168677;10827;10905.182111341523;10931.890681093088 07:17:16 INFO - PROCESS | 3438 | __end_tp_report 07:17:16 INFO - PROCESS | 3438 | __start_cc_report 07:17:16 INFO - PROCESS | 3438 | _x_x_mozilla_cycle_collect,308 07:17:16 INFO - PROCESS | 3438 | __end_cc_report 07:17:16 INFO - PROCESS | 3438 | __startTimestamp1468592236904__endTimestamp 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | ------- Summary: start ------- 07:17:16 INFO - PROCESS | 3438 | Number of tests: 6 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | [#0] dojo.html Cycles:165 Average:5481.52 Median:5661.86 stddev:597.51 (10.6%) stddev-sans-first:574.54 07:17:16 INFO - PROCESS | 3438 | Values: 3309.7 3344.8 3350.1 3368.8 3389.7 5516.1 5521.4 5529.0 5556.0 5582.8 5497.5 5510.1 5527.4 5537.9 5554.0 4999.3 5061.2 5069.8 5081.2 5090.6 5002.2 5044.2 5050.1 5054.9 5104.6 5035.9 5065.2 5072.0 5089.2 5091.1 5065.8 5070.3 5079.8 5084.0 5104.5 4961.8 4971.6 4981.5 4987.9 5019.3 5308.6 5327.5 5334.1 5341.1 5352.2 5797.9 5805.9 5809.4 5812.7 5817.5 5854.1 5924.3 5961.1 5989.7 6014.6 5509.9 5516.8 5518.3 5524.7 5525.8 5921.3 5935.3 5938.3 5945.9 5977.9 5746.6 5764.3 5790.4 5796.6 5828.3 5860.8 5861.0 5861.1 5862.9 5863.6 5733.5 5774.0 5823.2 5829.3 5851.6 5849.8 5854.8 5860.3 5866.7 5879.5 4489.0 4504.8 4513.4 4517.0 4537.1 3995.3 4030.7 4045.9 4051.4 4067.5 5534.9 5593.8 5595.7 5618.2 5628.1 5918.2 5921.5 5925.6 5926.2 5937.1 5407.8 5535.0 5629.0 5639.5 5723.1 5126.9 5130.2 5132.7 5139.0 5144.6 6134.5 6188.0 6205.6 6212.6 6224.9 5858.9 5960.5 5988.2 5988.3 5995.5 6120.8 6195.8 6196.9 6206.1 6210.1 5702.0 5724.6 5831.4 5838.1 5845.7 5894.9 5913.7 5923.2 5941.8 5970.9 5759.3 5760.0 5761.7 5766.1 5775.5 5666.3 5705.9 5709.6 5746.9 5787.0 5635.0 5655.9 5656.0 5656.7 5661.9 5697.1 5721.7 5722.0 5770.1 5773.6 5517.8 5628.7 5642.6 5650.6 5733.4 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | [#1] ext.html Cycles:180 Average:62697.77 Median:40598.30 stddev:134949.93 (332.4%) stddev-sans-first:135248.12 07:17:16 INFO - PROCESS | 3438 | Values: 661.6 679.8 681.7 727.5 740.8 31382.0 39962.0 40476.0 40720.6 40831.6 42884.0 43886.8 44025.3 44081.8 44233.8 8574.9 8767.3 8793.3 8817.7 8824.8 8774.0 8841.4 8887.0 8904.5 8909.1 9151.3 9245.5 9246.6 9251.6 9258.4 9129.6 9139.4 9199.6 9203.7 9210.8 9052.6 9174.2 9174.2 9180.4 9184.9 44182.0 44733.1 44818.6 44902.3 44920.0 3733.8 3880.6 3903.7 3915.4 3968.5 33982.3 34117.3 34413.8 34735.7 34748.5 4504.0 4629.9 4642.6 4677.0 4693.7 314510.0 316241.0 318382.0 319872.0 320220.0 39481.4 62231.7 62772.0 62783.4 62837.4 38200.4 38318.8 38331.6 38346.4 38355.2 16498.5 16714.1 16716.6 16733.1 16759.6 14785.2 14833.9 14884.3 14973.6 14997.4 9188.9 9194.8 9282.1 9302.4 9304.4 3476.9 3530.9 3536.0 3550.0 3604.1 1126.9 1186.3 1229.6 1239.9 1251.1 32490.1 32613.8 32894.7 33146.3 33415.7 1233.8 1237.0 1237.6 1249.3 1257.4 16903.3 17105.0 17483.8 17540.0 17568.2 529421.0 535704.0 610016.0 619759.0 959678.0 56535.7 57622.0 57756.0 57799.7 58177.4 1549.3 1557.1 1562.5 1569.6 1633.0 30825.8 31183.0 31420.0 31794.4 32238.5 54939.5 55495.4 55577.0 55580.4 55709.0 456112.0 457011.0 459692.0 461508.0 463431.0 30949.0 31737.2 31801.5 31928.4 31971.4 50433.2 51274.0 52544.2 52557.5 52661.0 38561.6 38607.8 43023.8 44701.0 44862.3 38417.4 38681.6 38997.2 39030.6 39612.8 41813.9 42468.8 42686.6 42732.4 42845.4 35701.6 36767.3 37190.3 37720.8 37808.0 28801.9 29371.6 29378.4 29438.3 29528.0 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | [#2] jquery.html Cycles:180 Average:31458.42 Median:40424.40 stddev:95151.35 (235.4%) stddev-sans-first:95389.72 07:17:16 INFO - PROCESS | 3438 | Values: 413.0 415.3 418.5 421.7 431.7 18711.7 19360.6 19409.9 19921.7 21280.5 19957.8 20340.5 20498.0 20557.6 20578.3 5716.0 5750.0 5933.3 5946.2 5986.3 5820.6 5883.0 5885.6 5887.2 5932.6 5624.5 5842.4 5848.4 5864.5 5872.3 5756.2 5762.7 5771.5 5799.4 5829.3 5184.4 5200.3 5207.6 5224.4 5232.3 23341.3 23889.5 24139.6 24371.0 24438.3 2621.8 2633.5 2884.1 3050.2 3136.8 14388.1 14898.8 15061.4 15163.5 15420.7 2058.5 2082.5 2184.2 2271.6 2296.3 78787.2 79683.0 81041.6 81195.2 81319.0 11662.8 11676.9 11740.7 11837.3 11935.1 16449.3 16489.7 16554.6 16562.3 16578.3 8853.0 8899.2 8957.1 9006.1 9139.2 8622.4 8684.6 8764.8 8820.6 8825.9 4908.9 5023.2 5062.6 5079.5 5138.3 2061.4 2109.8 2115.3 2139.3 2167.5 474.1 1053.3 1117.9 1123.8 1215.4 11184.8 11740.4 11804.6 11979.9 12028.7 486.6 497.6 509.7 515.7 517.2 6488.6 6585.6 6585.9 6594.1 6599.4 556207.0 570685.0 585110.0 590726.0 593111.0 76320.2 90284.0 91582.5 98546.5 106116.5 1122.5 1126.1 1129.6 1168.1 1168.2 17341.2 18111.7 18489.8 18618.0 18809.2 26841.9 39723.8 41125.0 41726.6 41791.0 61034.0 61141.7 61357.4 61571.7 62151.4 8858.6 8870.7 8940.7 9031.2 9052.0 11891.4 12360.3 12424.3 12665.5 12734.8 10840.5 11040.6 11174.5 11236.9 11402.2 10804.6 11128.2 11365.1 11380.3 11758.2 11671.6 11736.2 11901.0 12004.6 12136.5 8938.2 8939.3 9030.4 9108.4 9140.0 8678.5 10471.6 10876.8 10904.1 10975.8 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | [#3] mootools.html Cycles:180 Average:5624.68 Median:5147.65 stddev:3041.20 (59.1%) stddev-sans-first:3034.07 07:17:16 INFO - PROCESS | 3438 | Values: 1518.8 1548.5 1719.0 1834.2 1844.4 7161.9 8071.9 8216.6 8479.9 8555.9 8212.4 8350.0 8378.7 8418.9 8436.0 2388.3 2412.9 2416.3 2417.6 2419.1 2383.9 2415.7 2423.8 2449.6 2450.6 2428.6 2449.4 2457.8 2469.0 2470.3 2430.8 2449.9 2455.0 2469.9 2471.7 2420.2 2436.7 2441.8 2450.5 2464.9 8324.1 8396.0 8401.8 8412.0 8417.3 5341.9 5377.2 5397.5 5436.7 5462.1 3564.2 3586.2 3590.4 3601.9 3698.1 1192.3 1288.2 1311.5 1328.7 2163.7 11243.4 11435.0 11437.6 11454.3 11866.5 4506.9 4569.8 4574.8 4606.5 4608.6 9361.6 9369.5 9378.7 9380.3 9422.5 5294.4 5328.5 5338.4 5341.1 5344.1 4882.1 5002.5 5003.8 5011.8 5057.7 3896.7 3967.6 3981.1 4036.1 4036.9 1239.5 1247.4 1249.6 1251.2 1258.7 881.8 910.3 998.9 1000.2 1003.4 5982.5 5990.2 6067.4 6077.9 6100.5 442.7 444.6 447.4 447.9 456.4 4011.2 4031.3 4081.7 4086.7 4158.7 10295.2 10775.7 10778.7 10782.9 10787.8 9943.4 10068.4 10083.2 10242.7 10644.9 7993.6 8136.4 8169.6 8173.9 8174.8 5650.9 5826.7 5827.3 5844.8 5866.6 9169.0 9292.2 9297.6 9395.3 9469.4 9142.2 9227.2 9375.7 9407.5 9644.1 6579.4 7354.2 7541.5 7587.2 7727.4 8097.7 8151.0 8160.0 8174.2 8206.1 7269.7 7348.0 7497.6 7553.5 7678.1 7331.4 7370.0 7396.1 7459.3 7463.1 6709.2 6713.0 6714.4 6718.4 6721.2 4762.5 4901.5 4903.3 5018.3 5242.2 5112.9 5182.4 5192.0 5214.0 5315.3 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | [#4] prototype.html Cycles:180 Average:5787.74 Median:6626.30 stddev:1739.86 (26.3%) stddev-sans-first:1696.07 07:17:16 INFO - PROCESS | 3438 | Values: 343.1 353.4 354.3 357.9 360.2 6381.9 6520.0 6550.1 6609.6 6624.2 6553.6 6590.3 6590.6 6593.1 6596.9 4964.6 4966.4 4967.6 4969.8 4974.0 4979.6 4980.4 4981.6 4982.8 4988.7 4942.0 4946.8 4947.7 4950.2 4954.8 4810.3 4946.0 4948.1 4953.1 4954.9 4303.8 4317.2 4323.0 4327.4 4333.8 6212.7 6235.3 6236.2 6296.7 6310.4 5759.2 5806.1 5809.4 5810.0 5824.4 6859.7 6897.1 6900.9 6902.8 6912.5 4709.9 4856.2 4860.8 4865.1 4867.2 7087.1 7100.1 7135.1 7156.8 7157.9 4934.0 4947.8 4953.7 4964.0 4966.3 5025.1 5031.2 5032.0 5034.7 5035.4 5778.2 5779.8 5782.4 5783.5 5792.6 6816.2 6949.3 6953.9 6956.4 6958.3 1752.3 1761.2 1774.6 1776.5 1780.2 1150.0 1153.7 1169.4 1185.4 1189.4 6626.5 6651.7 6654.6 6657.2 6667.6 7045.4 7055.0 7062.4 7065.0 7067.9 6626.1 6628.9 6640.2 6642.9 6646.0 3801.6 3815.1 3840.0 3840.3 3842.4 7281.3 7461.5 7461.7 7562.1 7589.7 7162.5 7192.3 7193.9 7197.2 7207.9 7381.7 7386.2 7393.4 7403.1 7445.5 6908.4 7016.5 7036.2 7036.4 7051.7 6895.6 6918.8 6931.4 6934.9 6939.6 7385.1 7403.8 7415.7 7429.6 7456.5 4955.3 4955.9 4960.0 4962.1 4970.4 7025.7 7055.0 7065.0 7068.7 7075.6 6754.6 6990.0 7003.0 7004.7 7008.5 6860.0 6936.4 6950.7 6957.2 6961.9 6860.1 6863.4 6875.5 6925.0 6938.7 6883.1 6966.3 7020.2 7027.5 7063.2 6654.4 6845.8 6851.7 6852.6 6857.8 07:17:16 INFO - PROCESS | 3438 | 07:17:16 INFO - PROCESS | 3438 | [#5] yui.html Cycles:180 Average:15604.21 Median:22475.78 stddev:17780.01 (79.1%) stddev-sans-first:17795.28 07:17:16 INFO - PROCESS | 3438 | Values: 830.9 870.5 909.2 915.3 931.6 13601.6 14842.7 15062.7 15080.5 15125.5 14158.1 14173.9 14252.9 14260.9 14314.1 864.0 877.2 878.7 883.8 894.6 870.9 876.6 879.1 880.5 881.1 933.6 936.6 939.6 940.5 942.3 931.1 931.2 931.5 932.5 934.7 685.6 686.5 686.6 686.9 689.4 13845.9 14130.5 14139.6 14141.2 14143.1 13982.7 14042.4 14081.0 14164.6 14247.1 12064.6 12129.0 12133.1 12136.5 12321.8 4048.7 4068.1 4073.6 4084.8 4105.2 54540.0 54925.7 55345.7 55399.4 55418.4 10918.0 10929.4 11016.6 11085.2 11145.4 19984.8 19991.8 20006.3 20030.1 20053.7 8327.4 8498.2 8540.4 8742.4 8750.3 4960.3 5039.9 5123.2 5138.5 5214.0 3554.0 3605.4 3617.8 3619.0 3627.0 662.6 673.6 675.6 676.1 677.3 789.4 826.5 831.4 838.3 861.4 9613.7 10086.0 10099.2 10311.0 10349.9 675.2 683.1 683.5 744.6 872.7 4716.7 4726.5 4813.7 4987.5 4988.1 60748.4 61647.4 61984.0 62074.4 62524.4 55410.4 55750.7 55942.4 56386.0 56892.7 47489.8 47713.0 52634.2 54529.2 62798.0 9718.3 10051.1 10085.5 10201.7 10423.5 39260.0 39662.0 40304.2 40358.8 40866.8 47708.0 50933.7 51723.7 51915.0 52211.5 13146.4 13493.0 13656.0 13721.5 13760.0 14358.6 14401.7 14498.3 14790.2 15532.7 13315.5 13606.7 13645.5 13655.0 13720.5 12948.8 13274.7 13322.7 13374.2 13407.1 13256.7 13621.3 13657.9 13983.8 14228.0 10706.8 10742.5 10900.9 10982.4 11042.7 10693.7 10698.7 10827.0 10905.2 10931.9 07:17:16 INFO - PROCESS | 3438 | -------- Summary: end -------- 07:17:16 INFO - PROCESS | 3438 | 07:17:17 INFO - TEST-INFO | 3438: exit 0 07:17:17 INFO - TEST-OK | dromaeo_css | took 1109575ms 07:17:17 INFO - TEST-START | kraken 07:17:17 INFO - operating with platform_type : linux_ 07:17:17 INFO - Initialising browser for kraken test... 07:17:17 INFO - TEST-INFO | started process 3678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzExP8A/profile http://localhost:56109/getInfo.html) 07:17:21 INFO - PROCESS | 3678 | 07:17:21 INFO - PROCESS | 3678 | (process:3756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:17:22 INFO - PROCESS | 3678 | __metrics Screen width/height:1600/1200 07:17:22 INFO - PROCESS | 3678 | colorDepth:24 07:17:22 INFO - PROCESS | 3678 | Browser inner width/height: 1024/697 07:17:22 INFO - PROCESS | 3678 | __metrics 07:17:23 ERROR - PROCESS | 3678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 07:17:24 INFO - TEST-INFO | 3678: exit 0 07:17:24 INFO - Browser initialized. 07:17:24 INFO - Running cycle 1/1 for kraken test... 07:17:24 INFO - TEST-INFO | started process 3806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzExP8A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:25 INFO - PROCESS | 3806 | 07:17:25 INFO - PROCESS | 3806 | (process:3876): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:17:35 INFO - PROCESS | 3806 | RSS: Main: 150294528 07:17:35 INFO - PROCESS | 3806 | 07:17:38 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56109/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:39 INFO - PROCESS | 3806 | RSS: Main: 156123136 07:17:39 INFO - PROCESS | 3806 | 07:17:41 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56109/tests/kraken/driver.html?testName=audio-dft) 07:17:42 INFO - PROCESS | 3806 | RSS: Main: 156041216 07:17:42 INFO - PROCESS | 3806 | 07:17:45 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56109/tests/kraken/driver.html?testName=audio-fft) 07:17:45 INFO - PROCESS | 3806 | RSS: Main: 156311552 07:17:45 INFO - PROCESS | 3806 | 07:17:47 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56109/tests/kraken/driver.html?testName=audio-oscillator) 07:17:48 INFO - PROCESS | 3806 | RSS: Main: 155971584 07:17:48 INFO - PROCESS | 3806 | 07:17:50 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56109/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:51 INFO - PROCESS | 3806 | RSS: Main: 155992064 07:17:51 INFO - PROCESS | 3806 | 07:17:54 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56109/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:54 INFO - PROCESS | 3806 | RSS: Main: 156536832 07:17:54 INFO - PROCESS | 3806 | 07:17:58 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56109/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:58 INFO - PROCESS | 3806 | RSS: Main: 156213248 07:17:58 INFO - PROCESS | 3806 | 07:18:01 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56109/tests/kraken/driver.html?testName=json-parse-financial) 07:18:02 INFO - PROCESS | 3806 | RSS: Main: 156033024 07:18:02 INFO - PROCESS | 3806 | 07:18:03 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56109/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:04 INFO - PROCESS | 3806 | RSS: Main: 155860992 07:18:04 INFO - PROCESS | 3806 | 07:18:06 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:06 INFO - PROCESS | 3806 | RSS: Main: 155922432 07:18:06 INFO - PROCESS | 3806 | 07:18:09 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:10 INFO - PROCESS | 3806 | RSS: Main: 156291072 07:18:10 INFO - PROCESS | 3806 | 07:18:12 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:13 INFO - PROCESS | 3806 | RSS: Main: 156839936 07:18:13 INFO - PROCESS | 3806 | 07:18:15 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:16 INFO - PROCESS | 3806 | RSS: Main: 156639232 07:18:16 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | Cycle 1(1): loaded http://localhost:56109/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56109/tests/kraken/driver.html?testName=ai-astar) 07:18:18 INFO - PROCESS | 3806 | RSS: Main: 157892608 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | __start_tp_report 07:18:18 INFO - PROCESS | 3806 | _x_x_mozilla_page_load 07:18:18 INFO - PROCESS | 3806 | _x_x_mozilla_page_load_details 07:18:18 INFO - PROCESS | 3806 | |i|pagename|runs| 07:18:18 INFO - PROCESS | 3806 | |0;ai-astar;109;110;104;109;110;111;99;110;111;111 07:18:18 INFO - PROCESS | 3806 | |1;audio-beat-detection;169;132;156;169;129;158;154;129;173;128 07:18:18 INFO - PROCESS | 3806 | |2;audio-dft;163;161;164;160;162;160;160;161;160;172 07:18:18 INFO - PROCESS | 3806 | |3;audio-fft;73;76;76;170;77;75;76;77;194;76 07:18:18 INFO - PROCESS | 3806 | |4;audio-oscillator;93;92;154;93;94;94;142;93;92;157 07:18:18 INFO - PROCESS | 3806 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 07:18:18 INFO - PROCESS | 3806 | |6;imaging-darkroom;146;147;146;153;146;146;146;147;146;146 07:18:18 INFO - PROCESS | 3806 | |7;imaging-desaturate;95;94;96;96;95;95;95;95;94;96 07:18:18 INFO - PROCESS | 3806 | |8;json-parse-financial;56;55;56;55;57;56;61;81;55;54 07:18:18 INFO - PROCESS | 3806 | |9;json-stringify-tinderbox;59;59;58;59;58;59;58;59;59;59 07:18:18 INFO - PROCESS | 3806 | |10;stanford-crypto-aes;77;74;74;76;75;74;77;80;76;75 07:18:18 INFO - PROCESS | 3806 | |11;stanford-crypto-ccm;121;118;118;114;119;116;117;120;135;132 07:18:18 INFO - PROCESS | 3806 | |12;stanford-crypto-pbkdf2;168;163;166;161;164;165;164;161;164;158 07:18:18 INFO - PROCESS | 3806 | |13;stanford-crypto-sha256-iterative;70;70;70;72;66;68;68;67;67;68 07:18:18 INFO - PROCESS | 3806 | __end_tp_report 07:18:18 INFO - PROCESS | 3806 | __start_cc_report 07:18:18 INFO - PROCESS | 3806 | _x_x_mozilla_cycle_collect,846 07:18:18 INFO - PROCESS | 3806 | __end_cc_report 07:18:18 INFO - PROCESS | 3806 | __startTimestamp1468592298544__endTimestamp 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | ------- Summary: start ------- 07:18:18 INFO - PROCESS | 3806 | Number of tests: 14 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.50 stddev:3.89 (3.5%) stddev-sans-first:4.12 07:18:18 INFO - PROCESS | 3806 | Values: 109.0 110.0 104.0 109.0 110.0 111.0 99.0 110.0 111.0 111.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:157.00 stddev:18.43 (11.7%) stddev-sans-first:18.17 07:18:18 INFO - PROCESS | 3806 | Values: 169.0 132.0 156.0 169.0 129.0 158.0 154.0 129.0 173.0 128.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#2] audio-dft Cycles:10 Average:162.30 Median:161.50 stddev:3.68 (2.3%) stddev-sans-first:3.90 07:18:18 INFO - PROCESS | 3806 | Values: 163.0 161.0 164.0 160.0 162.0 160.0 160.0 161.0 160.0 172.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#3] audio-fft Cycles:10 Average:97.00 Median:76.00 stddev:45.17 (59.4%) stddev-sans-first:47.07 07:18:18 INFO - PROCESS | 3806 | Values: 73.0 76.0 76.0 170.0 77.0 75.0 76.0 77.0 194.0 76.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:93.00 stddev:28.27 (30.4%) stddev-sans-first:29.28 07:18:18 INFO - PROCESS | 3806 | Values: 93.0 92.0 154.0 93.0 94.0 94.0 142.0 93.0 92.0 157.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:18:18 INFO - PROCESS | 3806 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.00 stddev:2.18 (1.5%) stddev-sans-first:2.29 07:18:18 INFO - PROCESS | 3806 | Values: 146.0 147.0 146.0 153.0 146.0 146.0 146.0 147.0 146.0 146.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 07:18:18 INFO - PROCESS | 3806 | Values: 95.0 94.0 96.0 96.0 95.0 95.0 95.0 95.0 94.0 96.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:56.00 stddev:8.10 (14.5%) stddev-sans-first:8.54 07:18:18 INFO - PROCESS | 3806 | Values: 56.0 55.0 56.0 55.0 57.0 56.0 61.0 81.0 55.0 54.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:18:18 INFO - PROCESS | 3806 | Values: 59.0 59.0 58.0 59.0 58.0 59.0 58.0 59.0 59.0 59.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.87 (2.5%) stddev-sans-first:1.94 07:18:18 INFO - PROCESS | 3806 | Values: 77.0 74.0 74.0 76.0 75.0 74.0 77.0 80.0 76.0 75.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:119.50 stddev:6.91 (5.8%) stddev-sans-first:7.33 07:18:18 INFO - PROCESS | 3806 | Values: 121.0 118.0 118.0 114.0 119.0 116.0 117.0 120.0 135.0 132.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:164.00 stddev:2.84 (1.7%) stddev-sans-first:2.47 07:18:18 INFO - PROCESS | 3806 | Values: 168.0 163.0 166.0 161.0 164.0 165.0 164.0 161.0 164.0 158.0 07:18:18 INFO - PROCESS | 3806 | 07:18:18 INFO - PROCESS | 3806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.84 (2.7%) stddev-sans-first:1.88 07:18:18 INFO - PROCESS | 3806 | Values: 70.0 70.0 70.0 72.0 66.0 68.0 68.0 67.0 67.0 68.0 07:18:18 INFO - PROCESS | 3806 | -------- Summary: end -------- 07:18:18 INFO - PROCESS | 3806 | 07:18:19 INFO - TEST-INFO | 3806: exit 0 07:18:19 INFO - TEST-OK | kraken | took 61857ms 07:18:19 INFO - SUITE-END | took 1171s 07:18:19 INFO - Completed test suite (00:19:31) 07:18:19 INFO - javascript benchmark 07:18:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.718673912717, 3344.799312041276, 3350.112220261631, 3368.814715190665, 3389.6610338966107, 5516.117421212607, 5521.420250873661, 5528.9999999999945, 5556.0, 5582.776688932443, 5497.505224529791, 5510.063289240828, 5527.447255274471, 5537.916931246034, 5554.028045092113, 4999.275105109766, 5061.240813877929, 5069.847904562869, 5081.161608334621, 5090.567301779353, 5002.174641184219, 5044.243363495469, 5050.090983622947, 5054.898902021957, 5104.591632669378, 5035.924461133086, 5065.214891691794, 5072.036313100518, 5089.185730283156, 5091.0581542414775, 5065.848024559269, 5070.29015937769, 5079.79680812767, 5084.0, 5104.5405913467785, 4961.801527938878, 4971.552560269557, 4981.501849815026, 4987.925181122286, 5019.347484826949, 5308.628396012281, 5327.520523152934, 5334.146536554133, 5341.1187154119525, 5352.2239275305255, 5797.869415463986, 5805.854853628651, 5809.419058094199, 5812.709364531799, 5817.476427121579, 5854.063349864044, 5924.318703349127, 5961.105834124873, 5989.670568118751, 6014.578979471439, 5509.862253443696, 5516.779328826842, 5518.310211223597, 5524.696141712204, 5525.806596769134, 5921.259842519685, 5935.287765468085, 5938.257717785277, 5945.910811337833, 5977.850553736104, 5746.597738158289, 5764.250647415893, 5790.420957904176, 5796.594238403356, 5828.300603927556, 5860.794872179454, 5861.0, 5861.062230043172, 5862.912056319158, 5863.589548731633, 5733.512651424676, 5774.0, 5823.242978412779, 5829.300483941955, 5851.590388672837, 5849.766009359663, 5854.765809367663, 5860.267466566679, 5866.677332746654, 5879.52963762898, 4489.0, 4504.797284122223, 4513.390692256569, 4516.954830451719, 4537.115262523842, 3995.260876737813, 4030.717849750489, 4045.8786236412957, 4051.372037334218, 4067.5322337930925, 5534.889302213933, 5593.804216852391, 5595.664260144405, 5618.241537392481, 5628.127640215773, 5918.201042859245, 5921.496672782776, 5925.585209035326, 5926.2295901532525, 5937.109433584997, 5407.783688652488, 5535.0, 5629.043062679354, 5639.520640745583, 5723.141528770718, 5126.871828204325, 5130.230465430215, 5132.743362831843, 5139.0, 5144.61415393847, 6134.539909506716, 6188.040853667689, 6205.565610407228, 6212.627242365473, 6224.9377506224355, 5858.941410585925, 5960.493358064613, 5988.221531200916, 5988.341282459013, 5995.46040856325, 6120.846978825565, 6195.81412557624, 6196.907046394398, 6206.131141640084, 6210.130581718653, 5702.0, 5724.57065720081, 5831.446012628793, 5838.065909454467, 5845.736941837713, 5894.852628684317, 5913.733881975408, 5923.229980102559, 5941.762329506944, 5970.850728731816, 5759.337676167127, 5760.020796464695, 5761.740721667451, 5766.106253530709, 5775.5090817281, 5666.320041595035, 5705.914411283917, 5709.571782116275, 5746.856328591819, 5787.016207244695, 5634.971825140848, 5655.858603534944, 5655.971720141373, 5656.717164141859, 5661.858453538694, 5697.145428185805, 5721.656700597978, 5722.0, 5770.105633626795, 5773.595848290747, 5517.806876759294, 5628.690422026828, 5642.605017648725, 5650.604457687922, 5733.397993210653], "value": 5443.466777684657, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.6030381770938, 679.8436359637286, 681.7477533312674, 727.487121579287, 740.7925780781383, 31382.0, 39962.0, 40476.0, 40720.59279407205, 40831.59168408315, 42884.0, 43886.78056609721, 44025.339619905724, 44081.77959110208, 44233.7788311058, 8574.871376929352, 8767.254783343391, 8793.340499462534, 8817.721430392588, 8824.823503529926, 8773.956130219372, 8841.425307355, 8886.955565222164, 8904.510251936174, 8909.109089091104, 9151.267898568098, 9245.491497967609, 9246.583903724348, 9251.583678734472, 9258.351915365927, 9129.634814607407, 9139.405938614002, 9199.586018629177, 9203.723888283363, 9210.76973075675, 9052.59263333145, 9174.174324310845, 9174.174324310845, 9180.44917304964, 9184.8622270666, 44182.0, 44733.10533789306, 44818.55181448209, 44902.32646510305, 44920.0, 3733.831977561016, 3880.5925377835483, 3903.6877049835944, 3915.353966595508, 3968.5436174839974, 33982.32035359279, 34117.31765364679, 34413.82793086043, 34735.65264347349, 34748.47877281843, 4504.0, 4629.884252893671, 4642.605378542828, 4676.953230467686, 4693.718376897397, 314510.0, 316241.0, 318382.0, 319872.0, 320220.0, 39481.40777888276, 62231.6888415555, 62772.0, 62783.37216627866, 62837.37162628315, 38200.426993595116, 38318.80840595779, 38331.616683832806, 38346.42480362797, 38355.232895341935, 16498.505044848673, 16714.08072555997, 16716.58208544796, 16733.079680617684, 16759.581010474834, 14785.186814725294, 14833.851661483248, 14884.255787210595, 14973.625659358386, 14997.400103995937, 9188.908110918805, 9194.816103678022, 9282.071792820663, 9302.441853488812, 9304.441733495876, 3476.878309259164, 3530.947035794465, 3536.0, 3549.9645003549635, 3604.0809593554, 1126.9463052046362, 1186.2822992089662, 1229.624964385853, 1239.9070069744805, 1251.130464327302, 32490.050596964258, 32613.836930815192, 32894.67105328964, 33146.33707325888, 33415.66584334174, 1233.7532493501335, 1236.9690757731128, 1237.622525129826, 1249.256692268099, 1257.390165769601, 16903.323867045427, 17104.973701577946, 17483.825161748475, 17540.035298058476, 17568.2094305754, 529421.0, 535704.0, 610016.0, 619759.0, 959678.0, 56535.71732141313, 57622.0, 57756.0, 57799.711001444724, 58177.418225818044, 1549.3028137338242, 1557.096883807389, 1562.4687606213715, 1569.6389830339085, 1632.9712281262966, 30825.845870770503, 31183.0, 31420.0, 31794.364112718078, 32238.516422253215, 54939.45060549343, 55495.44504554903, 55577.0, 55580.44419555915, 55709.0, 456112.0, 457011.0, 459692.0, 461508.0, 463431.0, 30949.0, 31737.20656983594, 31801.5229771549, 31928.36143277168, 31971.36057278888, 50433.24350134678, 51274.0, 52544.21183682324, 52557.47442525679, 52661.0, 38561.614383855805, 38607.8417647471, 43023.78488107539, 44700.98845551893, 44862.3270650947, 38417.4237386445, 38681.613183868925, 38997.22005559816, 39030.6096939027, 39612.80193599014, 41813.90930453526, 42468.78765606152, 42686.5731342695, 42732.35901461543, 42845.35731963961, 35701.64298357087, 36767.26465470622, 37190.25619487649, 37720.811395942845, 37808.0, 28801.855990719912, 29371.57721114087, 29378.412431751673, 29438.264043399085, 29528.0], "value": 19896.44071663684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.9958700412996, 415.26498098365875, 418.4978026368359, 421.7090207756648, 431.6719293337063, 18711.71932421013, 19360.612787744256, 19409.902950485244, 19921.701174482394, 21280.46798830026, 19957.800421995777, 20340.491487712814, 20498.0, 20557.588848223026, 20578.279760208396, 5715.99999999999, 5750.0, 5933.317668468138, 5946.197263369433, 5986.2517185351835, 5820.621659592134, 5883.0, 5885.588008839383, 5887.175795388649, 5932.555058370618, 5624.521915637176, 5842.415758424166, 5848.41515848416, 5864.501517371007, 5872.265966754156, 5756.165356023374, 5762.74067666956, 5771.451712087345, 5799.420057994209, 5829.300483941933, 5184.377874655065, 5200.271961925334, 5207.6354655174155, 5224.39919409269, 5232.319798426181, 23341.299761007198, 23889.52220955571, 24139.63790543143, 24371.0, 24438.266851994467, 2621.829581077243, 2633.47330533894, 2884.120343295294, 3050.23744063984, 3136.8431578420987, 14388.064775789644, 14898.776518352233, 15061.397544098332, 15163.545093647208, 15420.691586168326, 2058.5162486815584, 2082.531430428157, 2184.1809321504434, 2271.5911135995516, 2296.276672848064, 78787.21212787856, 79683.0, 81041.59479202566, 81195.18804811935, 81319.0, 11662.825057624143, 11676.941615292038, 11740.70648233801, 11837.348945808064, 11935.104867135, 16449.342026318813, 16489.6702065958, 16554.58613534647, 16562.337506499603, 16578.253978570992, 8853.0, 8899.15458031486, 8957.14907083826, 9006.054364291786, 9139.177474027236, 8622.396432249809, 8684.60919258635, 8764.824703506021, 8820.647174112964, 8825.91174088251, 4908.92636610444, 5023.246513023076, 5062.645614806928, 5079.466656001141, 5138.254953031789, 2061.443410279246, 2109.831213502916, 2115.3019503563787, 2139.3261122746285, 2167.5014746608053, 474.09447954406915, 1053.257453495284, 1117.921745477825, 1123.842662027317, 1215.4057662037512, 11184.776304473866, 11740.354280514483, 11804.58683946075, 11979.880201198052, 12028.699282518008, 486.5890700797261, 497.562145312123, 509.74003258338513, 515.6570880364516, 517.2086707337779, 6488.610683359014, 6585.5719378240265, 6585.9012114818315, 6594.109795177686, 6599.373059559334, 556207.0, 570685.0, 585110.0, 590726.0, 593111.0, 76320.23679763131, 90284.0, 91582.54208728914, 98546.50726746464, 106116.46941765396, 1122.5117074072805, 1126.1328776841785, 1129.5651174297955, 1168.1005625668188, 1168.193946177135, 17341.219645115747, 18111.728324074887, 18489.81510184881, 18617.976011319508, 18809.153588088295, 26841.865790670923, 39723.80138099291, 41125.0, 41726.61870503645, 41790.95522611959, 61034.0, 61141.694291528256, 61357.38642613517, 61571.692141539, 62151.37848621456, 8858.601362938554, 8870.689525866565, 8940.689147005052, 9031.232345250464, 9051.954740226256, 11891.405429728306, 12360.320182390054, 12424.316662583644, 12665.493380264686, 12734.808977865525, 10840.45797710127, 11040.558377664804, 11174.49714762854, 11236.94381528087, 11402.20184587071, 10804.621838235624, 11128.165387596124, 11365.090792736726, 11380.317180969168, 11758.176927615326, 11671.59149429766, 11736.178467507192, 11901.0, 12004.579839705568, 12136.453859576517, 8938.195562399154, 8939.284857211538, 9030.413023153475, 9108.407953483002, 9139.954300228455, 8678.479291242546, 10471.63349282802, 10876.836847447137, 10904.12766978624, 10975.835362469728], "value": 9192.487891545481, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.7949626800382, 1548.512218651125, 1718.9914050429745, 1834.1562881074706, 1844.3636945253884, 7161.89257161143, 8071.878921816177, 8216.630251638675, 8479.872801907968, 8555.871661925075, 8212.425130240885, 8350.039745429278, 8378.706745263917, 8418.873716894252, 8435.957820210906, 2388.295452841407, 2412.9034838606435, 2416.299273210767, 2417.5648383291, 2419.11702228687, 2383.892724827378, 2415.698037745282, 2423.7939775119135, 2449.5590793657134, 2450.5588993981078, 2428.5871401861637, 2449.3998970252314, 2457.7910877575428, 2469.0, 2470.2712699753524, 2430.793382562484, 2449.9265022049367, 2454.963175552377, 2469.9012039518398, 2471.666325046123, 2420.225527831095, 2436.671049408325, 2441.7558244175616, 2450.546648869965, 2464.8521088734733, 8324.125966773463, 8395.95802020986, 8401.789955251168, 8411.95794021032, 8417.326613870875, 5341.866453338659, 5377.220303056074, 5397.487238712316, 5436.673799571999, 5462.0987537056335, 3564.2336897567147, 3586.228960773446, 3590.4434812604086, 3601.94597081044, 3698.0754811297174, 1192.296545038423, 1288.1948782011243, 1311.5016293808387, 1328.701042265492, 2163.653815389546, 11243.381614011227, 11435.0, 11437.59968401102, 11454.25547339412, 11866.52533898643, 4506.909861802811, 4569.794359253841, 4574.771261436915, 4606.539346065367, 4608.6082682971655, 9361.578728957076, 9369.531523423802, 9378.718638440858, 9380.296477764196, 9422.481763502936, 5294.444083371268, 5328.49379308965, 5338.3593968724, 5341.0653135701095, 5344.091504444254, 4882.096812089775, 5002.474740152305, 5003.849884503398, 5011.824586139468, 5057.72182529957, 3896.7272290939363, 3967.563568007517, 3981.144054028398, 4036.0918793271867, 4036.8990775230855, 1239.4608345369793, 1247.4324182496941, 1249.6001279590444, 1251.205484517338, 1258.7293731847515, 881.7751473374249, 910.253592054509, 998.8651532043226, 1000.1998401278947, 1003.4430890855646, 5982.49148822355, 5990.191324171268, 6067.423594758491, 6077.908831367533, 6100.450959413585, 442.6945407668698, 444.5554445554446, 447.4027173723116, 447.8768338706882, 456.4294631710362, 4011.176406248495, 4031.254217969685, 4081.7142800003717, 4086.6730661547003, 4158.6673066155245, 10295.176385889112, 10775.676729698122, 10778.676639700821, 10782.892171078345, 10787.83818242727, 9943.353682010791, 10068.446235456973, 10083.243756718275, 10242.743931401774, 10644.946775266075, 7993.600319983978, 8136.389770767216, 8169.63236654352, 8173.918260817316, 8174.836503269901, 5650.915236271541, 5826.73779679907, 5827.329857066492, 5844.795432159854, 5866.5893387462465, 9168.954155229449, 9292.16370526656, 9297.581608827755, 9395.2953528487, 9469.384490008128, 9142.22291105237, 9227.169554740105, 9375.671851485165, 9407.4825884577, 9644.083812037845, 6579.407853293226, 7354.191038985814, 7541.472096953161, 7587.165411804807, 7727.381809455343, 8097.716579919675, 8150.98112735908, 8160.020797504338, 8174.182581741778, 8206.097329293892, 7269.709211631475, 7347.963260183665, 7497.587632680255, 7553.471257011956, 7678.1170165431695, 7331.376832969044, 7370.041894553674, 7396.149442814145, 7459.2540745927145, 7463.141738700119, 6709.228438729609, 6713.0, 6714.3957043866285, 6718.361755633207, 6721.193456785217, 4762.499937506512, 4901.50984901507, 4903.26451032348, 5018.322526458881, 5242.18746094356, 5112.897742045213, 5182.404023537341, 5192.0, 5213.973930130325, 5315.255864178941], "value": 4531.204414714826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.142144638404, 353.4397979202963, 354.33208402161927, 357.92483578448525, 360.17519879476004, 6381.936180638192, 6519.967400162993, 6550.115734375858, 6609.636469994149, 6624.205095388554, 6553.606783592988, 6590.275069742324, 6590.60456372618, 6593.109930159427, 6596.868062638744, 4964.602831773458, 4966.428860681014, 4967.552920237178, 4969.776360063805, 4974.0, 4979.626528010395, 4980.352554167971, 4981.5516603505675, 4982.800687972477, 4988.65079444439, 4942.0, 4946.802127914879, 4947.653664243504, 4950.232713929328, 4954.826581069663, 4810.278458231258, 4946.0, 4948.134076536628, 4953.10844048073, 4954.925676114844, 4303.849365272201, 4317.201317756225, 4323.048929235563, 4327.394164816928, 4333.804978775963, 6212.65830379329, 6235.282942461629, 6236.189295391616, 6296.653684047421, 6310.432061114476, 5759.1937128802, 5806.1000544915605, 5809.3609702932645, 5810.041343178371, 5824.359320474744, 6859.725610975555, 6897.068895699117, 6900.930990690079, 6902.792916212471, 6912.516123871331, 4709.929351059737, 4856.17445034345, 4860.781264843091, 4865.148598995162, 4867.221244600847, 7087.1495420549345, 7100.112485939258, 7135.143782746104, 7156.821079473003, 7157.89263161053, 4933.950660493421, 4947.802087916443, 4953.678010929278, 4963.975180124076, 4966.304717339575, 5025.095482813055, 5031.245313202976, 5032.0, 5034.672746271481, 5035.370578677665, 5778.248827652378, 5779.797707080316, 5782.421757824268, 5783.537317014629, 5792.623479473821, 6816.216135144522, 6949.30506949301, 6953.930460695429, 6956.373926346653, 6958.304169583002, 1752.2903224194222, 1761.2250609731677, 1774.5829730013436, 1776.4581802550088, 1780.2167046499499, 1150.0, 1153.7173392518887, 1169.351010189336, 1185.4132204558798, 1189.4409627475072, 6626.469882409396, 6651.700673469705, 6654.633995130217, 6657.23441804189, 6667.63328016954, 7045.365917067488, 7055.0, 7062.364387205176, 7064.964675176694, 7067.858642827115, 6626.138601981712, 6628.933710662928, 6640.169978752656, 6642.86714265712, 6646.036324732887, 3801.5628202756484, 3815.141593141521, 3839.9616003839606, 3840.2703486338064, 3842.366009608383, 7281.344678978918, 7461.515001524884, 7461.664225109775, 7562.054743157106, 7589.658465369072, 7162.4986250962975, 7192.28077192287, 7193.856122877618, 7197.172325182566, 7207.89188162178, 7381.741639042608, 7386.187519372865, 7393.445491588045, 7403.111626604842, 7445.516041457397, 6908.44732421395, 7016.473764467787, 7036.190838053484, 7036.366726994595, 7051.717931282691, 6895.620740859301, 6918.757843475454, 6931.376176143969, 6934.93065069363, 6939.618320992394, 7385.113786345673, 7403.814904627212, 7415.740449084256, 7429.628518574158, 7456.478046536908, 4955.281484184845, 4955.900881982412, 4960.032793605356, 4962.131626965339, 4970.403551573834, 7025.68384422692, 7055.0, 7065.0, 7068.68190931399, 7075.575465472089, 6754.5609535380045, 6989.965050174716, 7003.0, 7004.719811207495, 7008.5094043416475, 6859.965700171467, 6936.375726184668, 6950.721971121098, 6957.234704182637, 6961.8955715665315, 6860.073890024983, 6863.38229559342, 6875.48433867452, 6924.965375173092, 6938.687759050956, 6883.139607549057, 6966.338197871194, 7020.227774944854, 7027.543209691354, 7063.187733410724, 6654.367835055662, 6845.760398386033, 6851.725930962905, 6852.554583952027, 6857.83416819132], "value": 5216.78444613309, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.9210624990627, 870.4777133719765, 909.1635695160454, 915.2906497464464, 931.590100355843, 13601.591952241437, 14842.703145937088, 15062.698746025073, 15080.472183473581, 15125.47060852869, 14158.079724817906, 14173.92913035436, 14252.928735356334, 14260.928695356535, 14314.069585476936, 863.9827203455943, 877.1623099939543, 878.6748902905933, 883.7569668341225, 894.5706061090681, 870.8563087090622, 876.5529579914257, 879.134052957836, 880.4717169698193, 881.1100788203928, 933.5985526223722, 936.5644975086583, 939.5724945149974, 940.5297351324338, 942.2697409507653, 931.1340453378356, 931.2270815223349, 931.483026920059, 932.5150921520805, 934.6541779541545, 685.5920727167328, 686.5468790598181, 686.615495322616, 686.8626274745071, 689.3554526517672, 13845.930770346184, 14130.50543230982, 14139.646508837259, 14141.222232777192, 14143.080699754482, 13982.72034559303, 14042.438302467888, 14081.0, 14164.57506274803, 14247.145171289652, 12064.638060858188, 12128.969037631812, 12133.090018248668, 12136.453859576251, 12321.815172772416, 4048.736832105933, 4068.1253530491085, 4073.572274911151, 4084.7549147050977, 4105.220008198433, 54540.0, 54925.725371373286, 55345.72327138379, 55399.44600553983, 55418.44581554214, 10918.0, 10929.398883061349, 11016.614418495314, 11085.22403431752, 11145.387003714712, 19984.800151998585, 19991.800081999285, 20006.299779507648, 20030.098645560985, 20053.699194512094, 8327.375446841512, 8498.150184981452, 8540.413744915553, 8742.431741936754, 8750.34372422071, 4960.330355402047, 5039.899202015939, 5123.154679477919, 5138.486151384832, 5214.009338225801, 3553.9822300888845, 3605.405108157177, 3617.8010209438207, 3618.9638103619154, 3627.0, 662.6392484798007, 673.6093066021696, 675.5946432140775, 676.0501495398972, 677.3463607618671, 789.3527307607707, 826.5371392020488, 831.4304701279643, 838.266516797802, 861.3841103610948, 9613.663521776703, 10086.0, 10099.242556808269, 10311.0, 10349.896501035044, 675.2403546010738, 683.0846665468297, 683.5010442377093, 744.5793126883293, 872.6858331000834, 4716.679329787665, 4726.480087190406, 4813.687110337817, 4987.476314986947, 4988.052270068675, 60748.39251607516, 61647.38352616506, 61984.0, 62074.379256207765, 62524.374756251855, 55410.445895541336, 55750.72124639351, 55942.44057559453, 56386.0, 56892.71553642288, 47489.76255118702, 47713.0, 52634.21048684273, 54529.1820622683, 62798.0, 9718.271129665161, 10051.095401413908, 10085.546150423103, 10201.693949181536, 10423.478826058818, 39260.0, 39662.0, 40304.1939161221, 40358.79820600878, 40866.79566602148, 47708.0, 50933.74533127311, 51723.74138129285, 51915.0, 52211.47788522218, 13146.408411621309, 13493.0, 13656.0, 13721.45114195421, 13759.96800240006, 14358.56924292273, 14401.711965760416, 14498.275086245434, 14790.186539739987, 15532.68934621324, 13315.533956311483, 13606.659833504242, 13645.454181832616, 13655.0, 13720.519781807589, 12948.761856544976, 13274.734505309647, 13322.733545329233, 13374.197548147142, 13407.061505694508, 13256.734865302833, 13621.25083120438, 13657.931710341385, 13983.790243146157, 14228.0, 10706.839397409201, 10742.462876856282, 10900.890991089987, 10982.395968221825, 11042.668719938414, 10693.686360481252, 10698.73253168677, 10827.0, 10905.182111341523, 10931.890681093088], "value": 7198.280932758642, "unit": "score"}], "name": "dromaeo_css", "value": 7438.657414722306, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 104.0, 109.0, 110.0, 111.0, 99.0, 110.0, 111.0, 111.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 132.0, 156.0, 169.0, 129.0, 158.0, 154.0, 129.0, 173.0, 128.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 160.0, 162.0, 160.0, 160.0, 161.0, 160.0, 172.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 170.0, 77.0, 75.0, 76.0, 77.0, 194.0, 76.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 154.0, 93.0, 94.0, 94.0, 142.0, 93.0, 92.0, 157.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 153.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 57.0, 56.0, 61.0, 81.0, 55.0, 54.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 76.0, 75.0, 74.0, 77.0, 80.0, 76.0, 75.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 118.0, 114.0, 119.0, 116.0, 117.0, 120.0, 135.0, 132.0], "value": 121.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 166.0, 161.0, 164.0, 165.0, 164.0, 161.0, 164.0, 158.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 72.0, 66.0, 68.0, 68.0, 67.0, 67.0, 68.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1533.0, "alertThreshold": 2.0}]} 07:18:19 INFO - Return code: 0 07:18:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:18:19 ERROR - # TBPL SUCCESS # 07:18:19 INFO - Running post-action listener: _resource_record_post_action 07:18:19 INFO - Running post-run listener: _resource_record_post_run 07:18:20 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 7774208; Write bytes: 364572672; Read time: 2212; Write time: 676160 07:18:20 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 20692992; Read time: 0; Write time: 18064 07:18:20 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 6012928; Write bytes: 343879680; Read time: 2036; Write time: 658096 07:18:20 INFO - Running post-run listener: _upload_blobber_files 07:18:20 INFO - Blob upload gear active. 07:18:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:20 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 07:18:20 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:18:20 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:18:21 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:22 INFO - (blobuploader) - INFO - Done attempting. 07:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:22 INFO - (blobuploader) - INFO - Done attempting. 07:18:22 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:22 INFO - Return code: 0 07:18:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ef54a7d900b4a06904ebc7225002b13c30e49ee40baaf00af09770dd1278ad59e7e4ee15f6eb94026a60753a17d3670d852cce9d7245468e69413a66239719a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9a4d6c6ee3fb1440ba5c7624b20935d4b25dfdc25161a158a0d0d49e9aa198f90d049b9dec63b56f2d5798fbcb5e41a149f8c73bed00bbad861f734a8298dd"} 07:18:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:22 INFO - Contents: 07:18:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ef54a7d900b4a06904ebc7225002b13c30e49ee40baaf00af09770dd1278ad59e7e4ee15f6eb94026a60753a17d3670d852cce9d7245468e69413a66239719a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9a4d6c6ee3fb1440ba5c7624b20935d4b25dfdc25161a158a0d0d49e9aa198f90d049b9dec63b56f2d5798fbcb5e41a149f8c73bed00bbad861f734a8298dd"} 07:18:22 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:22 INFO - Copying logs to upload dir... 07:18:22 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.049964 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-15 07:18:23.045999) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:23.049604) ========= 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=af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369 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-Beta/sha512/9ef54a7d900b4a06904ebc7225002b13c30e49ee40baaf00af09770dd1278ad59e7e4ee15f6eb94026a60753a17d3670d852cce9d7245468e69413a66239719a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9a4d6c6ee3fb1440ba5c7624b20935d4b25dfdc25161a158a0d0d49e9aa198f90d049b9dec63b56f2d5798fbcb5e41a149f8c73bed00bbad861f734a8298dd"} build_url:https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/NGn3eO6jR0ChGEaGD1dogQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9ef54a7d900b4a06904ebc7225002b13c30e49ee40baaf00af09770dd1278ad59e7e4ee15f6eb94026a60753a17d3670d852cce9d7245468e69413a66239719a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de9a4d6c6ee3fb1440ba5c7624b20935d4b25dfdc25161a158a0d0d49e9aa198f90d049b9dec63b56f2d5798fbcb5e41a149f8c73bed00bbad861f734a8298dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:23.074319) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:23.074630) ========= 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=af724c981e2a0f424dbabf99000001e7-1468590552.285051-2128568369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:18:23.157132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:18:23.157459) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:18:23.157744) ========= ========= Total master_lag: 0.19 =========