builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1466441545.79 results: success (0) buildid: 20160620070425 builduid: 6b5e7b7430ee456c8f22171c26de6907 revision: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:25.788017) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:25.788554) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:25.788836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:25.811549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:25.811896) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1466440725.976668-303672476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-20 09:52:25-- 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% 34.5M=0s 2016-06-20 09:52:26 (34.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:25.948725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:25.949092) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1466440725.976668-303672476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018072 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:26.006215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 09:52:26.006603) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11986e1994456d9d8c4a006caa8e15bd1c8410f1 --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 11986e1994456d9d8c4a006caa8e15bd1c8410f1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1466440725.976668-303672476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-20 09:52:26,172 truncating revision to first 12 chars 2016-06-20 09:52:26,172 Setting DEBUG logging. 2016-06-20 09:52:26,172 attempt 1/10 2016-06-20 09:52:26,172 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/11986e199445?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-20 09:52:26,917 unpacking tar archive at: mozilla-beta-11986e199445/testing/mozharness/ program finished with exit code 0 elapsedTime=1.064758 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-20 09:52:27.084753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:27.085119) ========= script_repo_revision: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:27.085521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:27.085792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-20 09:52:27.096575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-20 09:52:27.096845) ========= /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=df17445c3590ff7897617a0e00000225-1466440725.976668-303672476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:52:27 INFO - MultiFileLogger online at 20160620 09:52:27 in /builds/slave/test 09:52:27 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 09:52:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:52:27 INFO - {'append_to_log': False, 09:52:27 INFO - 'base_work_dir': '/builds/slave/test', 09:52:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:52:27 INFO - 'branch': 'Mozilla-Beta', 09:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:27 INFO - 'config_files': ('talos/linux_config.py',), 09:52:27 INFO - 'default_actions': ('clobber', 09:52:27 INFO - 'read-buildbot-config', 09:52:27 INFO - 'download-and-extract', 09:52:27 INFO - 'populate-webroot', 09:52:27 INFO - 'create-virtualenv', 09:52:27 INFO - 'install', 09:52:27 INFO - 'run-tests'), 09:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:27 INFO - 'download_minidump_stackwalk': True, 09:52:27 INFO - 'download_symbols': 'ondemand', 09:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:27 INFO - 'installer_path': 'installer.exe', 09:52:27 INFO - 'log_level': 'info', 09:52:27 INFO - 'log_name': 'talos', 09:52:27 INFO - 'log_to_console': True, 09:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:52:27 INFO - 'opt_config_files': (), 09:52:27 INFO - 'pip_index': False, 09:52:27 INFO - 'sps_profile': False, 09:52:27 INFO - 'sps_profile_interval': 0, 09:52:27 INFO - 'suite': 'dromaeojs-e10s', 09:52:27 INFO - 'system_bits': '32', 09:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:27 INFO - 'title': 'talos-linux64-ix-021', 09:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:27 INFO - 'use_talos_json': True, 09:52:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:27 INFO - 'work_dir': 'build'} 09:52:27 INFO - ##### 09:52:27 INFO - ##### Running clobber step. 09:52:27 INFO - ##### 09:52:27 INFO - Running pre-action listener: _resource_record_pre_action 09:52:27 INFO - Running main action method: clobber 09:52:27 INFO - rmtree: /builds/slave/test/build 09:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:52:27 INFO - Running post-action listener: _resource_record_post_action 09:52:27 INFO - ##### 09:52:27 INFO - ##### Running read-buildbot-config step. 09:52:27 INFO - ##### 09:52:27 INFO - Running pre-action listener: _resource_record_pre_action 09:52:27 INFO - Running main action method: read_buildbot_config 09:52:27 INFO - Using buildbot properties: 09:52:27 INFO - { 09:52:27 INFO - "project": "", 09:52:27 INFO - "product": "firefox", 09:52:27 INFO - "script_repo_revision": "production", 09:52:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 09:52:27 INFO - "repository": "", 09:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 09:52:27 INFO - "buildid": "20160620070425", 09:52:27 INFO - "pgo_build": "True", 09:52:27 INFO - "basedir": "/builds/slave/test", 09:52:27 INFO - "buildnumber": 41, 09:52:27 INFO - "slavename": "talos-linux64-ix-021", 09:52:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:52:27 INFO - "platform": "ubuntu64_hw", 09:52:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:52:27 INFO - "branch": "mozilla-beta", 09:52:27 INFO - "repo_path": "releases/mozilla-beta", 09:52:27 INFO - "revision": "11986e1994456d9d8c4a006caa8e15bd1c8410f1", 09:52:27 INFO - "stage_platform": "linux64-pgo", 09:52:27 INFO - "builduid": "6b5e7b7430ee456c8f22171c26de6907", 09:52:27 INFO - "slavebuilddir": "test" 09:52:27 INFO - } 09:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 09:52:27 INFO - Running post-action listener: _resource_record_post_action 09:52:27 INFO - ##### 09:52:27 INFO - ##### Running download-and-extract step. 09:52:27 INFO - ##### 09:52:27 INFO - Running pre-action listener: _resource_record_pre_action 09:52:27 INFO - Running main action method: download_and_extract 09:52:27 INFO - mkdir: /builds/slave/test/build/tests 09:52: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')]} 09:52:27 INFO - https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:30 INFO - Downloaded 1327 bytes. 09:52:30 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 09:52:30 INFO - Using the following test package requirements: 09:52:30 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:52:30 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:52:30 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 09:52:30 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'jsshell-linux-x86_64.zip'], 09:52:30 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:52:30 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 09:52:30 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 09:52:30 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 09:52:30 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:52:30 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 09:52:30 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:52:30 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:52: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')]} 09:52:30 INFO - https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:32 INFO - Downloaded 24189562 bytes. 09:52:32 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'] 09:52:32 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 09:52:33 INFO - Return code: 0 09:52:33 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 09:52:33 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')]} 09:52:33 INFO - https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:52:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:52:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 09:52:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:38 INFO - Downloaded 24189562 bytes. 09:52:38 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'] 09:52:38 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 09:52:39 INFO - Return code: 0 09:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:39 INFO - https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 09:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:40 INFO - Downloaded 10840145 bytes. 09:52:40 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'] 09:52:40 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 09:52:41 INFO - Return code: 0 09:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:41 INFO - https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EhRjyXnZRJaBVrAqdMet_A/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 09:52:42 INFO - Downloaded 56013812 bytes. 09:52:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:52:42 INFO - mkdir: /builds/slave/test/properties 09:52:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:52:42 INFO - Writing to file /builds/slave/test/properties/build_url 09:52:42 INFO - Contents: 09:52:42 INFO - build_url:https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 09:52:43 INFO - Running post-action listener: _resource_record_post_action 09:52:43 INFO - Running post-action listener: set_extra_try_arguments 09:52:43 INFO - ##### 09:52:43 INFO - ##### Running populate-webroot step. 09:52:43 INFO - ##### 09:52:43 INFO - Running pre-action listener: _resource_record_pre_action 09:52:43 INFO - Running main action method: populate_webroot 09:52:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:43 INFO - '--tppagecycles', 09:52:43 INFO - '7'], 09:52:43 INFO - 'tests': ['tsvgm']}}, 09:52:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:52:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:52:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:52:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['damp', 'tps']}, 09:52:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'tests': ['damp', 'tps']}, 09:52:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['dromaeo_dom']}, 09:52:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['a11yr', 09:52:43 INFO - 'ts_paint', 09:52:43 INFO - 'tpaint', 09:52:43 INFO - 'sessionrestore', 09:52:43 INFO - 'sessionrestore_no_auto_restore', 09:52:43 INFO - 'tabpaint']}, 09:52:43 INFO - 'other-e10s': {'tests': ['a11yr', 09:52:43 INFO - 'ts_paint', 09:52:43 INFO - 'tpaint', 09:52:43 INFO - 'sessionrestore', 09:52:43 INFO - 'sessionrestore_no_auto_restore', 09:52:43 INFO - 'tabpaint']}, 09:52:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:52:43 INFO - 'ts_paint', 09:52:43 INFO - 'tpaint', 09:52:43 INFO - 'sessionrestore', 09:52:43 INFO - 'sessionrestore_no_auto_restore', 09:52:43 INFO - 'tabpaint']}, 09:52:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:52:43 INFO - 'ts_paint', 09:52:43 INFO - 'tpaint', 09:52:43 INFO - 'sessionrestore', 09:52:43 INFO - 'sessionrestore_no_auto_restore', 09:52:43 INFO - 'tabpaint']}, 09:52:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['a11yr', 09:52:43 INFO - 'ts_paint', 09:52:43 INFO - 'tpaint', 09:52:43 INFO - 'sessionrestore', 09:52:43 INFO - 'sessionrestore_no_auto_restore', 09:52:43 INFO - 'tabpaint']}, 09:52:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['a11yr', 09:52:43 INFO - 'ts_paint', 09:52:43 INFO - 'tpaint', 09:52:43 INFO - 'sessionrestore', 09:52:43 INFO - 'sessionrestore_no_auto_restore', 09:52:43 INFO - 'tabpaint']}, 09:52:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['tsvgx', 09:52:43 INFO - 'tsvgr_opacity', 09:52:43 INFO - 'tart', 09:52:43 INFO - 'tscrollx', 09:52:43 INFO - 'cart']}, 09:52:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:52:43 INFO - 'tsvgr_opacity', 09:52:43 INFO - 'tart', 09:52:43 INFO - 'tscrollx', 09:52:43 INFO - 'cart']}, 09:52:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'talos_options': ['--disable-e10s'], 09:52:43 INFO - 'tests': ['tp5o']}, 09:52:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'tests': ['tp5o']}, 09:52:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'talos_options': ['--disable-e10s', 09:52:43 INFO - '--xperf_path', 09:52:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:43 INFO - 'tests': ['tp5n']}, 09:52:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:43 INFO - 'talos_options': ['--xperf_path', 09:52:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:43 INFO - 'tests': ['tp5n']}}, 09:52:43 INFO - 'talos.zip': {'path': '', 09:52:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:43 INFO - Running post-action listener: _resource_record_post_action 09:52:43 INFO - ##### 09:52:43 INFO - ##### Running create-virtualenv step. 09:52:43 INFO - ##### 09:52:43 INFO - Running pre-action listener: _resource_record_pre_action 09:52:43 INFO - Running main action method: create_virtualenv 09:52:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:52:43 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 09:52:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:52:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:43 INFO - Using real prefix '/usr' 09:52:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:52:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:46 INFO - Installing pip.................done. 09:52:46 INFO - Return code: 0 09:52:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:46 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 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:52:46 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 09:52:46 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 09:52:46 INFO - Using env: {'DISPLAY': ':0', 09:52:46 INFO - 'HOME': '/home/cltbld', 09:52:46 INFO - 'LANG': 'en_US.UTF-8', 09:52:46 INFO - 'LANGUAGE': 'en_US:en', 09:52:46 INFO - 'LOGNAME': 'cltbld', 09:52:46 INFO - 'MAIL': '/var/mail/cltbld', 09:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:46 INFO - 'MOZ_NO_REMOTE': '1', 09:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:46 INFO - 'NO_EM_RESTART': '1', 09:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:46 INFO - 'PWD': '/builds/slave/test', 09:52:46 INFO - 'SHELL': '/bin/bash', 09:52:46 INFO - 'SHLVL': '1', 09:52:46 INFO - 'TERM': 'linux', 09:52:46 INFO - 'TMOUT': '86400', 09:52:46 INFO - 'USER': 'cltbld', 09:52:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:46 INFO - '_': '/tools/buildbot/bin/python'} 09:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:46 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 09:52:46 INFO - Cleaning up... 09:52:46 INFO - Return code: 0 09:52:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:46 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 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:52:46 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 09:52:46 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 09:52:46 INFO - Using env: {'DISPLAY': ':0', 09:52:46 INFO - 'HOME': '/home/cltbld', 09:52:46 INFO - 'LANG': 'en_US.UTF-8', 09:52:46 INFO - 'LANGUAGE': 'en_US:en', 09:52:46 INFO - 'LOGNAME': 'cltbld', 09:52:46 INFO - 'MAIL': '/var/mail/cltbld', 09:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:46 INFO - 'MOZ_NO_REMOTE': '1', 09:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:46 INFO - 'NO_EM_RESTART': '1', 09:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:46 INFO - 'PWD': '/builds/slave/test', 09:52:46 INFO - 'SHELL': '/bin/bash', 09:52:46 INFO - 'SHLVL': '1', 09:52:46 INFO - 'TERM': 'linux', 09:52:46 INFO - 'TMOUT': '86400', 09:52:46 INFO - 'USER': 'cltbld', 09:52:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:46 INFO - '_': '/tools/buildbot/bin/python'} 09:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:46 INFO - Downloading/unpacking psutil>=0.7.1 09:52:46 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 09:52:46 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 09:52:46 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 09:52:46 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 09:52:46 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 09:52:46 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 09:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:48 INFO - Installing collected packages: psutil 09:52:48 INFO - Running setup.py install for psutil 09:52:48 INFO - building 'psutil._psutil_linux' extension 09:52:48 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 09:52:48 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 09:52:48 INFO - building 'psutil._psutil_posix' extension 09:52:48 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 09:52:49 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 09:52:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:49 INFO - Successfully installed psutil 09:52:49 INFO - Cleaning up... 09:52:49 INFO - Return code: 0 09:52:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:52: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')]} 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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')]} 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:52:49 INFO - Using env: {'DISPLAY': ':0', 09:52:49 INFO - 'HOME': '/home/cltbld', 09:52:49 INFO - 'LANG': 'en_US.UTF-8', 09:52:49 INFO - 'LANGUAGE': 'en_US:en', 09:52:49 INFO - 'LOGNAME': 'cltbld', 09:52:49 INFO - 'MAIL': '/var/mail/cltbld', 09:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:49 INFO - 'MOZ_NO_REMOTE': '1', 09:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:49 INFO - 'NO_EM_RESTART': '1', 09:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:49 INFO - 'PWD': '/builds/slave/test', 09:52:49 INFO - 'SHELL': '/bin/bash', 09:52:49 INFO - 'SHLVL': '1', 09:52:49 INFO - 'TERM': 'linux', 09:52:49 INFO - 'TMOUT': '86400', 09:52:49 INFO - 'USER': 'cltbld', 09:52:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:49 INFO - '_': '/tools/buildbot/bin/python'} 09:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:52:51 INFO - Installing collected packages: mozsystemmonitor 09:52:51 INFO - Running setup.py install for mozsystemmonitor 09:52:51 INFO - Successfully installed mozsystemmonitor 09:52:51 INFO - Cleaning up... 09:52:51 INFO - Return code: 0 09:52:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:52:51 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')]} 09:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:51 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')]} 09:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:52:52 INFO - Using env: {'DISPLAY': ':0', 09:52:52 INFO - 'HOME': '/home/cltbld', 09:52:52 INFO - 'LANG': 'en_US.UTF-8', 09:52:52 INFO - 'LANGUAGE': 'en_US:en', 09:52:52 INFO - 'LOGNAME': 'cltbld', 09:52:52 INFO - 'MAIL': '/var/mail/cltbld', 09:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:52 INFO - 'MOZ_NO_REMOTE': '1', 09:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:52 INFO - 'NO_EM_RESTART': '1', 09:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:52 INFO - 'PWD': '/builds/slave/test', 09:52:52 INFO - 'SHELL': '/bin/bash', 09:52:52 INFO - 'SHLVL': '1', 09:52:52 INFO - 'TERM': 'linux', 09:52:52 INFO - 'TMOUT': '86400', 09:52:52 INFO - 'USER': 'cltbld', 09:52:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:52 INFO - '_': '/tools/buildbot/bin/python'} 09:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52:55 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 09:52:55 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 09:52:55 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 09:52:55 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 09:52:55 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 09:52:55 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 09:52:55 INFO - Downloading docopt-0.6.1.tar.gz 09:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:55 INFO - Running setup.py install for blobuploader 09:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:52:55 INFO - Running setup.py install for requests 09:52:56 INFO - Running setup.py install for docopt 09:52:57 INFO - Successfully installed blobuploader requests docopt 09:52:57 INFO - Cleaning up... 09:52:58 INFO - Return code: 0 09:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:52:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:52:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:52:58 INFO - Using env: {'DISPLAY': ':0', 09:52:58 INFO - 'HOME': '/home/cltbld', 09:52:58 INFO - 'LANG': 'en_US.UTF-8', 09:52:58 INFO - 'LANGUAGE': 'en_US:en', 09:52:58 INFO - 'LOGNAME': 'cltbld', 09:52:58 INFO - 'MAIL': '/var/mail/cltbld', 09:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:58 INFO - 'MOZ_NO_REMOTE': '1', 09:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:58 INFO - 'NO_EM_RESTART': '1', 09:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:58 INFO - 'PWD': '/builds/slave/test', 09:52:58 INFO - 'SHELL': '/bin/bash', 09:52:58 INFO - 'SHLVL': '1', 09:52:58 INFO - 'TERM': 'linux', 09:52:58 INFO - 'TMOUT': '86400', 09:52:58 INFO - 'USER': 'cltbld', 09:52:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:58 INFO - '_': '/tools/buildbot/bin/python'} 09:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:52:58 INFO - Running setup.py (path:/tmp/pip-sb6WxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:52:58 INFO - Running setup.py (path:/tmp/pip-CHZ2D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:52:58 INFO - Running setup.py (path:/tmp/pip-KCFSIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:52:58 INFO - Running setup.py (path:/tmp/pip-lYto5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:52:58 INFO - Running setup.py (path:/tmp/pip-zZw19k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:52:58 INFO - Running setup.py (path:/tmp/pip-tFITZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:52:58 INFO - Running setup.py (path:/tmp/pip-D2pDXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:52:58 INFO - Running setup.py (path:/tmp/pip-FXFf8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:52:58 INFO - Running setup.py (path:/tmp/pip-0OPCJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:52:59 INFO - Running setup.py (path:/tmp/pip-2HNFs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:52:59 INFO - Running setup.py (path:/tmp/pip-FjmVR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:52:59 INFO - Running setup.py (path:/tmp/pip-N9OoW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:52:59 INFO - Running setup.py (path:/tmp/pip-8hTGZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:52:59 INFO - Running setup.py (path:/tmp/pip-Nxzn0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:59 INFO - Running setup.py (path:/tmp/pip-crVkF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:52:59 INFO - Running setup.py (path:/tmp/pip-Vlvfut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:52:59 INFO - Running setup.py (path:/tmp/pip-yLL3AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:52:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:59 INFO - Running setup.py install for manifestparser 09:52:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:52:59 INFO - Running setup.py install for mozcrash 09:52:59 INFO - Running setup.py install for mozdebug 09:52:59 INFO - Running setup.py install for mozdevice 09:53:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozfile 09:53:00 INFO - Running setup.py install for mozhttpd 09:53:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozinfo 09:53:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozInstall 09:53:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozleak 09:53:00 INFO - Running setup.py install for mozlog 09:53:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for moznetwork 09:53:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozprocess 09:53:00 INFO - Running setup.py install for mozprofile 09:53:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:53:00 INFO - Running setup.py install for mozrunner 09:53:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Running setup.py install for mozscreenshot 09:53:01 INFO - Running setup.py install for moztest 09:53:01 INFO - Running setup.py install for mozversion 09:53:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:53:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:53:01 INFO - Cleaning up... 09:53:01 INFO - Return code: 0 09:53:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:53:01 INFO - Using env: {'DISPLAY': ':0', 09:53:01 INFO - 'HOME': '/home/cltbld', 09:53:01 INFO - 'LANG': 'en_US.UTF-8', 09:53:01 INFO - 'LANGUAGE': 'en_US:en', 09:53:01 INFO - 'LOGNAME': 'cltbld', 09:53:01 INFO - 'MAIL': '/var/mail/cltbld', 09:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:01 INFO - 'MOZ_NO_REMOTE': '1', 09:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:01 INFO - 'NO_EM_RESTART': '1', 09:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:01 INFO - 'PWD': '/builds/slave/test', 09:53:01 INFO - 'SHELL': '/bin/bash', 09:53:01 INFO - 'SHLVL': '1', 09:53:01 INFO - 'TERM': 'linux', 09:53:01 INFO - 'TMOUT': '86400', 09:53:01 INFO - 'USER': 'cltbld', 09:53:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:01 INFO - '_': '/tools/buildbot/bin/python'} 09:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:53:01 INFO - Running setup.py (path:/tmp/pip-JeOzt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:53:01 INFO - Running setup.py (path:/tmp/pip-nQz7CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:53:01 INFO - Running setup.py (path:/tmp/pip-J51HYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:53:01 INFO - Running setup.py (path:/tmp/pip-2Mb8L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:53:01 INFO - Running setup.py (path:/tmp/pip-XZh_2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:53:01 INFO - Running setup.py (path:/tmp/pip-840elR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:53:02 INFO - Running setup.py (path:/tmp/pip-V5t0xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:53:02 INFO - Running setup.py (path:/tmp/pip-vpEvXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:53:02 INFO - Running setup.py (path:/tmp/pip-oJMjP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:53:02 INFO - Running setup.py (path:/tmp/pip-VhTkAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:53:02 INFO - Running setup.py (path:/tmp/pip-cLMpA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:53:02 INFO - Running setup.py (path:/tmp/pip-I1H0oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:53:02 INFO - Running setup.py (path:/tmp/pip-5R5Pu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:53:02 INFO - Running setup.py (path:/tmp/pip-P7Rc4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:02 INFO - Running setup.py (path:/tmp/pip-p_EjR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:53:02 INFO - Running setup.py (path:/tmp/pip-hqDTSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:53:02 INFO - Running setup.py (path:/tmp/pip-brsiQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:53:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:04 INFO - Downloading blessings-1.6.tar.gz 09:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:53:04 INFO - Installing collected packages: blessings 09:53:04 INFO - Running setup.py install for blessings 09:53:04 INFO - Successfully installed blessings 09:53:04 INFO - Cleaning up... 09:53:04 INFO - Return code: 0 09:53:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:05 INFO - Reading from file tmpfile_stdout 09:53:05 INFO - Current package versions: 09:53:05 INFO - argparse == 1.2.1 09:53:05 INFO - blessings == 1.6 09:53:05 INFO - blobuploader == 1.2.4 09:53:05 INFO - docopt == 0.6.1 09:53:05 INFO - manifestparser == 1.1 09:53:05 INFO - mozInstall == 1.12 09:53:05 INFO - mozcrash == 0.17 09:53:05 INFO - mozdebug == 0.1 09:53:05 INFO - mozdevice == 0.48 09:53:05 INFO - mozfile == 1.2 09:53:05 INFO - mozhttpd == 0.7 09:53:05 INFO - mozinfo == 0.9 09:53:05 INFO - mozleak == 0.1 09:53:05 INFO - mozlog == 3.1 09:53:05 INFO - moznetwork == 0.27 09:53:05 INFO - mozprocess == 0.22 09:53:05 INFO - mozprofile == 0.28 09:53:05 INFO - mozrunner == 6.11 09:53:05 INFO - mozscreenshot == 0.1 09:53:05 INFO - mozsystemmonitor == 0.0 09:53:05 INFO - moztest == 0.7 09:53:05 INFO - mozversion == 1.4 09:53:05 INFO - psutil == 3.1.1 09:53:05 INFO - requests == 1.2.3 09:53:05 INFO - wsgiref == 0.1.2 09:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:53:05 INFO - Using env: {'DISPLAY': ':0', 09:53:05 INFO - 'HOME': '/home/cltbld', 09:53:05 INFO - 'LANG': 'en_US.UTF-8', 09:53:05 INFO - 'LANGUAGE': 'en_US:en', 09:53:05 INFO - 'LOGNAME': 'cltbld', 09:53:05 INFO - 'MAIL': '/var/mail/cltbld', 09:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:05 INFO - 'MOZ_NO_REMOTE': '1', 09:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:05 INFO - 'NO_EM_RESTART': '1', 09:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:05 INFO - 'PWD': '/builds/slave/test', 09:53:05 INFO - 'SHELL': '/bin/bash', 09:53:05 INFO - 'SHLVL': '1', 09:53:05 INFO - 'TERM': 'linux', 09:53:05 INFO - 'TMOUT': '86400', 09:53:05 INFO - 'USER': 'cltbld', 09:53:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:05 INFO - '_': '/tools/buildbot/bin/python'} 09:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:53:05 INFO - Cleaning up... 09:53:05 INFO - Return code: 0 09:53:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:53:05 INFO - Using env: {'DISPLAY': ':0', 09:53:05 INFO - 'HOME': '/home/cltbld', 09:53:05 INFO - 'LANG': 'en_US.UTF-8', 09:53:05 INFO - 'LANGUAGE': 'en_US:en', 09:53:05 INFO - 'LOGNAME': 'cltbld', 09:53:05 INFO - 'MAIL': '/var/mail/cltbld', 09:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:05 INFO - 'MOZ_NO_REMOTE': '1', 09:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:05 INFO - 'NO_EM_RESTART': '1', 09:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:05 INFO - 'PWD': '/builds/slave/test', 09:53:05 INFO - 'SHELL': '/bin/bash', 09:53:05 INFO - 'SHLVL': '1', 09:53:05 INFO - 'TERM': 'linux', 09:53:05 INFO - 'TMOUT': '86400', 09:53:05 INFO - 'USER': 'cltbld', 09:53:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:05 INFO - '_': '/tools/buildbot/bin/python'} 09:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:05 INFO - Downloading/unpacking jsonschema 09:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:53:07 INFO - Downloading/unpacking functools32 (from jsonschema) 09:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:53:07 INFO - warning: no files found matching '*.txt' 09:53:07 INFO - no previously-included directories found matching 'build' 09:53:07 INFO - no previously-included directories found matching 'dist' 09:53:07 INFO - no previously-included directories found matching '.git*' 09:53:07 INFO - Installing collected packages: jsonschema, functools32 09:53:07 INFO - Running setup.py install for functools32 09:53:07 INFO - warning: no files found matching '*.txt' 09:53:07 INFO - no previously-included directories found matching 'build' 09:53:07 INFO - no previously-included directories found matching 'dist' 09:53:07 INFO - no previously-included directories found matching '.git*' 09:53:07 INFO - Successfully installed jsonschema functools32 09:53:07 INFO - Cleaning up... 09:53:07 INFO - Return code: 0 09:53:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:53: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')]} 09:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53: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')]} 09:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:53:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e78a57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25305a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', '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 09:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:53:07 INFO - Using env: {'DISPLAY': ':0', 09:53:07 INFO - 'HOME': '/home/cltbld', 09:53:07 INFO - 'LANG': 'en_US.UTF-8', 09:53:07 INFO - 'LANGUAGE': 'en_US:en', 09:53:07 INFO - 'LOGNAME': 'cltbld', 09:53:07 INFO - 'MAIL': '/var/mail/cltbld', 09:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:07 INFO - 'MOZ_NO_REMOTE': '1', 09:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:07 INFO - 'NO_EM_RESTART': '1', 09:53:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:07 INFO - 'PWD': '/builds/slave/test', 09:53:07 INFO - 'SHELL': '/bin/bash', 09:53:07 INFO - 'SHLVL': '1', 09:53:07 INFO - 'TERM': 'linux', 09:53:07 INFO - 'TMOUT': '86400', 09:53:07 INFO - 'USER': 'cltbld', 09:53:07 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:07 INFO - '_': '/tools/buildbot/bin/python'} 09:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:53:08 INFO - Downloading/unpacking flake8 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53: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 09:53:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:53:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:53:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:10 INFO - no previously-included directories found matching 'docs/_build' 09:53:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:53:10 INFO - Running setup.py install for pep8 09:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:53:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:53:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:53:10 INFO - no previously-included directories found matching 'docs/_build' 09:53:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:53:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:53:11 INFO - Cleaning up... 09:53:11 INFO - Return code: 0 09:53:11 INFO - Running post-action listener: _resource_record_post_action 09:53:11 INFO - Running post-action listener: _start_resource_monitoring 09:53:11 INFO - Starting resource monitoring. 09:53:11 INFO - ##### 09:53:11 INFO - ##### Running install step. 09:53:11 INFO - ##### 09:53:11 INFO - Running pre-action listener: _resource_record_pre_action 09:53:11 INFO - Running main action method: install 09:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:53:11 INFO - Reading from file tmpfile_stdout 09:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:53:11 INFO - Reading from file tmpfile_stdout 09:53:11 INFO - Output received: 09:53:11 INFO - Usage: mozinstall [options] installer 09:53:11 INFO - Options: 09:53:11 INFO - -h, --help show this help message and exit 09:53:11 INFO - -d DEST, --destination=DEST 09:53:11 INFO - Directory to install application into. [default: 09:53:11 INFO - "/builds/slave/test"] 09:53:11 INFO - --app=APP Application being installed. [default: firefox] 09:53:11 INFO - mkdir: /builds/slave/test/build/application 09:53:11 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'] 09:53:11 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 09:53:24 INFO - Reading from file tmpfile_stdout 09:53:24 INFO - Output received: 09:53:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:53:24 INFO - Running post-action listener: _resource_record_post_action 09:53:24 INFO - ##### 09:53:24 INFO - ##### Running run-tests step. 09:53:24 INFO - ##### 09:53:24 INFO - Running pre-action listener: _resource_record_pre_action 09:53:24 INFO - Running main action method: run_tests 09:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:53:24 INFO - Python 2.7.3 09:53:24 INFO - Return code: 0 09:53:24 INFO - grabbing minidump binary from tooltool 09:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:53:24 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 0x25bf410>, '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 0x25c0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:53:24 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 09:53:24 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 09:53:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:24 INFO - Return code: 0 09:53:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:53:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:53:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:53:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:53:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:53:25 INFO - Return code: 0 09:53:25 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/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:53:25 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/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:53:25 INFO - Using env: {'DISPLAY': ':0', 09:53:25 INFO - 'HOME': '/home/cltbld', 09:53:25 INFO - 'LANG': 'en_US.UTF-8', 09:53:25 INFO - 'LANGUAGE': 'en_US:en', 09:53:25 INFO - 'LOGNAME': 'cltbld', 09:53:25 INFO - 'MAIL': '/var/mail/cltbld', 09:53:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:53:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:25 INFO - 'MOZ_NO_REMOTE': '1', 09:53:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:25 INFO - 'NO_EM_RESTART': '1', 09:53:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:53:25 INFO - 'PWD': '/builds/slave/test', 09:53:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:53:25 INFO - 'SHELL': '/bin/bash', 09:53:25 INFO - 'SHLVL': '1', 09:53:25 INFO - 'TERM': 'linux', 09:53:25 INFO - 'TMOUT': '86400', 09:53:25 INFO - 'USER': 'cltbld', 09:53:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1466440725.976668-303672476', 09:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:25 INFO - '_': '/tools/buildbot/bin/python'} 09:53:25 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/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:53:25 INFO - mozversion application_buildid: 20160620070425 09:53:25 INFO - mozversion application_changeset: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 09:53:25 INFO - mozversion application_display_name: Firefox 09:53:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:25 INFO - mozversion application_name: Firefox 09:53:25 INFO - mozversion application_remotingname: firefox 09:53:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:53:25 INFO - mozversion application_vendor: Mozilla 09:53:25 INFO - mozversion application_version: 48.0 09:53:25 INFO - mozversion platform_buildid: 20160620070425 09:53:25 INFO - mozversion platform_changeset: 11986e1994456d9d8c4a006caa8e15bd1c8410f1 09:53:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:53:25 INFO - mozversion platform_version: 48.0 09:53:25 INFO - using testdate: 1466441605 09:53:25 INFO - actual date: 1466441605 09:53:25 INFO - starting webserver on 'localhost:34425' 09:53:25 INFO - SUITE-START | Running 2 tests 09:53:25 INFO - TEST-START | dromaeo_css 09:53:25 INFO - operating with platform_type : linux_ 09:53:25 INFO - Initialising browser for dromaeo_css test... 09:53:25 INFO - TEST-INFO | started process 4700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1HN2H/profile http://localhost:34425/getInfo.html) 09:53:30 INFO - PROCESS | 4700 | 09:53:30 INFO - PROCESS | 4700 | (process:4775): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:53:31 INFO - PROCESS | 4700 | __metrics Screen width/height:1600/1200 09:53:31 INFO - PROCESS | 4700 | colorDepth:24 09:53:31 INFO - PROCESS | 4700 | Browser inner width/height: 1024/697 09:53:31 INFO - PROCESS | 4700 | __metrics 09:53:32 ERROR - PROCESS | 4700 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 09:53:33 INFO - TEST-INFO | 4700: exit 0 09:53:33 INFO - Browser initialized. 09:53:33 INFO - Running cycle 1/1 for dromaeo_css test... 09:53:33 INFO - TEST-INFO | started process 4826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1HN2H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:35 INFO - PROCESS | 4826 | 09:53:35 INFO - PROCESS | 4826 | (process:4894): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:53:45 INFO - PROCESS | 4826 | RSS: Main: 151859200 09:53:45 INFO - PROCESS | 4826 | 09:54:35 INFO - PROCESS | 4826 | 1466441675418 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] 09:56:42 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:34425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34425/tests/dromaeo/cssquery-ext.html) 09:56:43 INFO - PROCESS | 4826 | RSS: Main: 156332032 09:56:43 INFO - PROCESS | 4826 | 09:59:45 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:34425/tests/dromaeo/cssquery-ext.html (next: http://localhost:34425/tests/dromaeo/cssquery-jquery.html) 09:59:46 INFO - PROCESS | 4826 | RSS: Main: 153358336 09:59:46 INFO - PROCESS | 4826 | 10:02:48 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:34425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34425/tests/dromaeo/cssquery-mootools.html) 10:02:48 INFO - PROCESS | 4826 | RSS: Main: 153038848 10:02:48 INFO - PROCESS | 4826 | 10:05:50 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:34425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34425/tests/dromaeo/cssquery-prototype.html) 10:05:50 INFO - PROCESS | 4826 | RSS: Main: 153976832 10:05:50 INFO - PROCESS | 4826 | 10:08:53 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:34425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34425/tests/dromaeo/cssquery-yui.html) 10:08:53 INFO - PROCESS | 4826 | RSS: Main: 152928256 10:08:53 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:34425/tests/dromaeo/cssquery-yui.html (next: http://localhost:34425/tests/dromaeo/cssquery-dojo.html) 10:11:56 INFO - PROCESS | 4826 | RSS: Main: 156991488 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | __start_tp_report 10:11:56 INFO - PROCESS | 4826 | _x_x_mozilla_page_load 10:11:56 INFO - PROCESS | 4826 | _x_x_mozilla_page_load_details 10:11:56 INFO - PROCESS | 4826 | |i|pagename|runs| 10:11:56 INFO - PROCESS | 4826 | |0;dojo.html;3317.9004629861106;3376.172837654775;3401.659834016598;3431.519587257783;3432.897013089607;5617.01702202115;5670.68811215383;5723.141528770687;5725.971370143144;5769.1923130761725;5683.232763576916;5769.942300576993;5774.105013722869;5788.42115788422;5791.160281759142;5128.743562821863;5186.818461353853;5240.056789777838;5268.631195816294;5307.73461326934;5089.949100508985;5136.409312929024;5356.143017117262;5362.0616392131415;5366.382865970424;5212.035773381917;5245.082110630643;5301.655392399482;5320.733963301839;5322.627416080876;5212.348456442964;5226.268322434862;5226.634135610509;5233.581313494911;5238.083335416287;5071;5127.307813445174;5218.478152184789;5232.607554433394;5257.553107985826;5448.891022179534;5531.640443371209;5594.748236329375;5606.074997625387;5610.298712660918;6099.786507472261;6133.969330153365;6137.140800287963;6141.570090093695;6145.354737752561;5972.6715030673295;6156.415140561639;6171.938280617182;6183.103449999725;6189.38106189382;5636.4927156556105;5649.745761440745;5685.0619647758485;5715.199872017921;5754.251947246873;6268.49852011838;6286.622802631857;6292.96166132583;6299.6535190564955;6308;6014.398560143951;6024.0662697282;6050.092486127116;6050.878982420415;6053.182820319289;6137.560853825989;6141;6143.354947730424;6167.506599472032;6187.752489900444;6080.878382432326;6121.234845644294;6142.815715528542;6153.784617538454;6164.845878853064;5900.144479050514;6094.695265236721;6112.716259964539;6128.1837556712435;6130.917941862977;4588.2658774596575;4588.334691469719;4591.104734576726;4610.469795973506;4614.630829533629;4107.383892416162;4109.178164367138;4114.238865809834;4141.585841415835;4148.0666849959125;5904.3210030847;5906.40935906406;5906.704664766745;5948.375420580864;5960.284765828128;5933.465988061095;6046.516278697693;6052.939470605325;6067.544934129958;6130.141780150782;5837;5881.411858814085;5883.382244864313;5886.58793884424;5897.911531327033;4908.092002979461;5038.823641172541;5083.288339632454;5089.745512724349;5104.183330667075;6380.457661098766;6384.872302554016;6391.041343798374;6405.03924411342;6415.775447859396;6162.907556386568;6164.4143806339225;6166.352532983972;6174.073888916699;6174.969125154345;6131.101423540838;6361.14124593174;6372.808815735535;6443.516736244706;6503.382178693017;6042.577019608585;6073.240844894388;6081.847953801191;6099;6100.908486372797;6186.81439556814;6187.721552530057;6192.59748116371;6193.721282542207;6197.349278325711;5774.913376299275;5986.461218490357;6044.274687037584;6045.667488288186;6080.939190608037;5867.413258674099;5955.315138758925;5959.880802383841;5961.165436838933;5970.134330522137;5690.743916523849;5879.029960056714;5891.49922256613;5892.970535147297;5903.970480147744;6011;6091.817245482643;6101.359357267423;6126.877462450815;6129.695011270001;5905.881882362242;5907.202527658711;5935;5944.6730429826775;5964.254468191476 10:11:56 INFO - PROCESS | 4826 | |1;ext.html;669.7007804858574;683.5659356308743;705.0305829484458;729.91605965314;775.9030121234846;38527.42208866866;40259.79870100649;40379.59620403795;40439.797801011024;40473.79763101184;40019.19961600766;40704.59295407045;40904.59095409045;40910.59089409105;41141.38287925676;8578.099299573532;8674.783130421727;8716.08481109484;8722.476651400904;8763.737087887373;8485.363597730164;8652.653893844239;8893.377463577552;8906.153915378029;8919.687810926587;8895.243904268113;8898.243649289785;8901.15439033294;8914.598843052077;8934.4192627479;8809.735707928772;8826.161514656098;8840.071792461795;8843.380963332569;8875.689350872688;8795.164459376349;9005.594748236344;9024.684136055272;9026.638934442615;9027.097290270985;40526;40761;41312.79343603293;41383.793081034404;43229.567704323184;3661.3226553087766;3814.370628846237;3851.6340947609933;4097.160082183145;4373.693841431101;31146.53280200776;31348.902788402524;31644.525332120036;31701.682983170103;31704.682953170402;4553;4606;4627.14397836398;4632.0967411354795;4643.3963584733765;321033;323027;324669;325279;325364;38846.41730374047;39253;65399.673001634685;66380;66441;37657.81171094127;37850.621493785264;37969.620303797165;38208.426873596916;38211.23577528434;16296.511104666879;16436.75344869828;16437.506874793777;16490.670186596442;16493.505194844172;13483.797743033861;13682.863171368159;13704.65738356529;13719.245441500812;13761.518346857813;9218.262538996863;9466.29002824791;9494.715158545254;9530;9565.234781217487;3660.5607327120915;3673.3571624966057;3738.738288319846;3747.6065013173225;3747.756395834262;1120.5573798349606;1147.9782993136116;1188.8097904335266;1246.1463897230426;1273;33500.16249593731;33894;33979.150521236676;34156.48765268523;34904.82547587246;1228.8218208359738;1233.340163012802;1237.8824011718873;1301.7201301720177;1331.034999625264;17231;17500;17571.209295581728;17693.292268309382;17717.911410442866;447116;554129;561555;572319;573041;62790;63075.05387419192;63590.682046590395;63827;64001.67999159975;1452.0561634937164;1470.375090586518;1487.5314276003242;1490.627343164209;1578.4902005810816;33053;33847.492287616195;34177.31645367029;34323.656763432045;34652.82673586616;54129.72935135299;54592;54639;54681.72659136679;54865.45134548763;419166;423554;424147;424901;427331;30508;31159.532607011366;31177.064688059396;31418.52872206873;31431.371372571964;49813.501864980884;50273;50816;51091;51228.74385628048;38889.222215556096;38977.41533876937;39255.214895701356;39355.212895742494;40254.194916100925;37446.2510749778;37686.2462750749;40239;41696.79151604223;41998;41871.79064104782;41956.58043419527;42615.36076958786;42652.78673606736;43023;36362;36520.81739591285;36968.45742198777;37124;37525.43711844379;28522.714772852007;29080;29218;29541.261468462602;29573 10:11:56 INFO - PROCESS | 4826 | |2;jquery.html;423.5235360219753;428.0881721932284;431;434.5372178629759;440.1263491968442;18427.907860460695;19214.903925480372;19277.421677349685;19574.608507829835;20541.486462838435;13024.869751302484;13194.274314912676;13754.518591849263;18660.81339186608;20511.692324615105;5232.1628539433605;5405.216243644689;5424.403315635277;5454.34547854256;5455.781768729246;5366.4633536646415;5761.913571296413;5770.076787713967;5771.480566748992;5787;5715.428457154293;5720.342160651516;5723.799667011655;5726.570507211955;5739.454751798593;5350.117230656956;5372.597055220874;5388.137897936351;5392.757325920343;5394.91907621386;5248.8425347239645;5255.0278198533015;5257.553107985787;5264.368275806889;5269.077911365534;17723.379681711078;23569;23854.16510422127;23881.40296492584;23940.76059239403;2334.8132149428006;2570.7043689975517;2620.580707086876;2849.088291746642;3082;10914.672559823219;12295.385230738428;13046.543370982065;14851.851481485155;15036.624084397869;1870.7848597411337;1925.4319975607089;2012.154894944127;2108.325335892515;2135.2099723102397;80025.59987200085;80281.59859200726;80935.59532202301;81287.18712812796;82480.58759706163;10330.863605003444;10441.634542790965;10566.31318964265;10731.463426828628;10752.623658171926;14779.852201478063;14900.403983840743;14901.1059336438;14918.627034324012;14945.925270373578;8381.371397145238;8442.282405995558;8443.662253509914;8543.188397102265;8659.653613855375;8385.790355241168;8440.57797110142;8449.450785699033;8522.190391912758;8633.568321583896;4383.693141480129;4445.155420470101;4574.817007319736;4775.808967641325;4844.297576851407;1860.9813901860807;1945.7081437784163;1958.1286327584373;1969.5765410436825;2037.7350944377433;1070.9678709638724;1157.1552766480515;1160.3038177093845;1173.4308860202796;1175.8530183727034;18860.811391885905;19051.809481905282;19346.129424175946;19612.509687257934;19920.90039549793;1069.1660504806264;1071.196602548089;1103.2167161315394;1107.2968664897687;1154.8440960470398;10807.513661885234;10998.945005274922;10999.34003959765;11046.447677616086;11197.048250898602;419077;422248;431105;562695;562992;82241;88300.55849720711;88475.55762221148;90178.54910725405;96238.51880740692;1125.0999200639455;1168.415792103931;1168.5384273212203;1171.84765980422;1174.2484809721784;17481.56296092608;17937.282508699507;18024.459266222035;18067.367642132464;18377.173027214074;37690.811545943194;38162;41730.374044389966;42351.788241058595;43698.781506092266;58233.70883145557;58709.70645146918;58959.115613266695;59094.40905590889;59419.702901485216;8404.663813447394;8703.695370661997;8815.206631403205;8854.867176992479;8956.193942545202;13507.324633768469;13583.32083395846;13612.523561675294;13684;13752.449902003807;8123.634436450256;10413.062824345845;11183.888161118284;11217.775644487228;11775.116866235237;11863.584774533196;11918.344491052729;11962;12188.939055304667;12196.878031219574;11505.539778408769;12005.39973001329;12359.62921112368;12648.241105533698;12897.161684490478;8374.790630234293;8615.784605384915;8626;9028.774280643036;9323.627054917728;11249.1563132767;11999.64001079969;12047.156699030984;12456.564020259248;12535.93732031334 10:11:56 INFO - PROCESS | 4826 | |3;mootools.html;1491.1276903011737;1534.6010037390283;1781.8396344329017;1937.060525645061;1966.783653798081;8504.744857654272;8699.260562852158;8730.214280714743;8792.604332805024;8932.285417166628;8902.77743056424;8942.64229430822;8986.775330616721;9013.909860901389;9014.954925225366;2448.2655203438985;2488.6764720586298;2490.2155820916355;2493.326801763523;2493.4015836199364;2471.406862353031;2481.8634975076366;2494.2018554062706;2497.2008957133726;2497.7627125423055;2454.9140780072703;2458.557459657261;2473.9010439582394;2479.2066538707622;2484.813638977075;2425.6967879015124;2427.9271621851285;2428.672129262545;2462.7167875694345;2464.864432456214;2491.190363131989;2493.8628375439343;2504.8371855829314;2522.7603377679093;2533.3033415810614;8770.868436973387;8779.64881404743;8793.824123517557;8797;8799.29605631548;5282.709450980195;5396.244525766396;5405.675659460445;5417.404085550586;5422.15956526739;3495.2659941412335;3498.9825050874583;3561.5904171020406;3567.571891373052;3577.695895848856;1206.179797737547;1283.570004048645;1291.9289439080846;1303.3157592264042;1312.822768926202;12290.938545307306;12378.690532736573;12382.133250672456;12384.071194660346;12438.315892625902;4517.186906356887;4617.607503362185;4635.096156249499;4652.232381657056;4672.579467847842;9929.404235745878;9937.10566049059;9938.900610993798;9962.601495940226;9978.800423991624;5323.0684630190335;5389.218563308298;5400.054990376669;5400.459954004568;5409.080456322435;4690.038542098861;4770.833020844254;4812.735299558488;4813.302071199656;5001.599872010231;3926.784026878492;4025.939610905839;4071.307877660805;4132.40080188377;4132.628063474302;1201.6214892308894;1205.8492688413949;1211.7818792617413;1216.8865488078309;1232.4022848918446;940.5062342270226;1014.8021135878433;1026.6560702164709;1036.4558606731375;1041.5833666533447;5745;5763.7982670606325;5791.7683292667825;5831.008728516163;5934.228550288435;465.27184955544465;466.9766511674471;470.7904982282851;1067.8665166854144;1076.0791986304566;4034.576369481221;4038;4047;4053.574374690615;4082.142750022469;10181.490925453698;10377.16982641402;10412.219083568763;10417.895821041844;10523.579056837641;10261.95434481521;10361.896381036244;10379.06588407047;10393;10406.323588966692;8140.185981401813;8352.081271060179;8372.497650141011;8383.245507904317;8387.077421483631;5863.442972917566;5923.170756094064;5982.49148822355;6026.668533230714;6144.201253836973;9621;9632.807343853225;9741.756456088655;9802.852957205505;9924.553395097093;9767.60929562838;9870.210383169186;10045.447500387549;10229.84655230187;10313.1233845124;7473.215312392121;7529.096508419025;7573.9242607573215;7666.080070391588;7819.0617125945255;8266.462679925786;8332.04181519133;8335.49987000782;8336.208060234268;8393.370497212856;7341.853162936604;7461.589612571361;7514.223565075023;7547;7624.199459056941;7001.929980700332;7090.361867431956;7098.787036388917;7186.1376634804155;7195.676194571152;6634.701438435185;6680.0647909291765;6750.561213521106;6757.831054223684;6772.492063095189;4997.900041999067;5028.094942910311;5052.545270925634;5141.665791723526;5194.117000109914;5123.462036486116;5123.615728820428;5126;5174.120399532013;5204.921926171035 10:11:56 INFO - PROCESS | 4826 | |4;prototype.html;352.85003873353816;361.3838405518591;362.34234863722344;370.9035650730809;374.3579760710383;6580.309067547911;6629.204495460552;6708.463322934166;6848.0755098061745;6881.174259088903;6590.934090659092;6655.667216639161;6672;6673.566218195814;6688.96655516723;5022.271770593262;5044.419891712445;5072.2391641253835;5073.086844368012;5075.898482030358;5084.135696931512;5086.237064440345;5091.949080509203;5092.185250359925;5094.847154585368;5040.949590504085;5047.798088076491;5048.7980480780725;5053.696778193302;5057.924131138036;4836.661433699643;4970.577500912426;5045.495450454961;5048.268001139832;5065.822696205633;4281.657467402601;4304.074623955865;4312.159128969852;4312.417823593806;4314.978425107885;6294.464970477515;6309.936900630981;6310.6213627182515;6312.936870631327;6316.778912738078;5803.5357171426185;5812.912806307909;5826.388229235911;5848.853778655525;5882.852928676774;7051.753188638373;7063.434925205971;7071.7878463646175;7075.929240707578;7078.823029424254;4696.342512048316;4854;4867.951320486821;4870.732109733964;4881.780319885614;7339.853202935911;7353.522021068614;7361.190269070452;7394.55632662042;7411.999380083674;4897.755112244445;4900.901981960412;4903.8528844134735;4911.18965370717;4927.236278376786;4983.252512123138;4994.425641051253;4995.450500444948;4998.100341938413;4998.725070121178;5833.67914764692;5841.707914604252;5850.4149585042005;5854.941450585525;5859.707014649251;6813.659317034128;7045.365917067386;7070.92929070713;7075.964620176969;7122.928770712227;1753.9123043848012;1763.2506184871636;1767.8939263644222;1769.133124768854;1775.849052830498;1129.305477131558;1134.3194083549804;1140.1505878120688;1152.458344578047;1153.377176324792;6830.214525329551;6866.485013623898;6876.312368763083;6878.071460352889;6885.380315771505;7265.09186351706;7274.345308922222;7315.122185337687;7324.560526368435;7329.083864516935;6818.761343352959;6822.829429264308;6824.931750682529;6830.726770929206;6832.829179270459;3903.1803321302277;3916.2167566486814;3959.6436320731273;3962.0887195945093;3963.2667956428154;7515.820412080436;7554;7561.886571701429;7563;7578.204288549733;7340.779776606711;7370.262973702587;7377.668004939791;7398.4081273497995;7401.8149546261775;7492.325690687864;7514.632890639431;7520.323170914644;7524.172341042481;7573.97751303578;7206;7265.564066156047;7274.236205198378;7283.6358182089625;7288.3076107769675;7259.891101633374;7263.273672632695;7325.560466372035;7330.193678695446;7331.670074846538;7749.302562769378;7802.375809935078;7820.921790782019;7826.530408175528;7843.84312313762;4953.826616068421;4986.775595098302;4996.975015124901;5008;5020.347354843847;7328.599327168142;7350.411967042731;7440.813979650336;7450.962745186456;7456.66445009965;7186.532875363085;7209.134903811576;7213.062301900719;7215.025971493781;7235.095613048369;7135.928640713526;7172.677229524579;7195.784126476214;7197.316254955771;7200.603966781878;7036.155661320674;7066.681999310146;7067.363937245673;7071.82320441993;7082.752103676346;6972.860542789217;7151;7175.46184036189;7236.276372362721;7249.202587715453;6878.105846239957;7051.894221586577;7080.362767350963;7099.148102227766;7110.964445177741 10:11:56 INFO - PROCESS | 4826 | |5;yui.html;831.713058994647;860.4837097741354;884.1556313720398;918.0544039639171;946.64629579701;16642.500724978254;16988;16999.915000424997;17011.064391458465;17011.319547218096;15542.989705669152;15573.065616063015;15647.217639118027;15658.84341156588;15743.291551880164;832.7834762961613;850.9914900850974;863.6890719341033;875.3434923807145;891.3760367742574;748.6593599912027;824.8309096635176;873.4977388001893;879.6525372477868;919.9264058875308;944.3908678902104;954.4559601027418;960.5869476125264;961.293449314753;964.5418426247511;921.5023887100991;946.4557879219442;952.4047470331043;954.370115723619;956.8564715292727;696.355870819495;696.4532841719276;698.8776964031325;701.039575781178;701.6491754122939;15330.846691533054;15369.308381122877;15374.692506149815;15393.384264629512;15447.227638618137;13981.720365592733;14088.436462541486;14095.295235238196;14136.22250776207;14228.786568201485;11597.409068261086;11659.766804663945;11838.585649502313;11868.228565143238;11904.642860714192;3932;3954.604539546051;3975.125472396097;4005.619466150711;4076.2662720710555;55398.72300638471;55441.44558554443;55584.44415555833;56282.43717562854;56607.15089273705;10949.124070074375;10952.507137178845;11375.658730238107;11449.427528623535;11454.541818327174;19890.70163947542;19925.302614408425;19930.402087937386;19951.301704440273;20254.69617955732;8548;8596.226339629338;8671.6531338747;8684.131586841266;8718.346124040723;4742.359781429532;4771.093492236464;4853.296272040534;4866.78099485524;4961.181405068123;3552.7157827374267;3587.0494319005484;3592.6586974237407;3595.442706380515;3604.675579197885;627.350692033752;647.2071712152575;648.844277373427;650.7331993882485;660.1154453032863;771.9498232614862;792.2275781113368;814.5723495164967;834.8163404051099;841.6086519768214;9512.90487095134;9821.084888446685;10167.186625069977;10209.489525523843;10211.336263143021;670.4669787518934;726.2628432141381;819.0989911097864;828.1511450762896;837.1544739812833;4555.9772201138785;4568.748718820497;4826.95173048265;4835.782389792468;4863.635227357891;60766.08850867241;60950;61352.69323653353;63094;63182.68408658019;53827.730861345444;54744.72627636836;55249;55391.72304138453;55595.44404555984;49999;50922;51016.74491627592;51045;51415.74292128516;9192.862107068533;9433.339666223574;9617.997660702455;9635.807283854423;9712.562934667816;37274;38187.80906095452;39419.40870886997;39511.407328889516;42075.47547147181;51152.48847511477;51190.48809512006;51556.484435155166;51565;52555.47444525506;12664.74670506603;12836.87163128394;12926.741465170831;13016.8047479286;13095.738085238052;13778.379972901042;13984.091034082752;14008.369623367176;14193.290335482978;14277.500287489887;13282.601521954357;13367;13390.799138012742;13411;13615.863841361459;13130.015248856183;13261.602151935458;13448.1258718183;13463.798043029557;13483.865161348653;12993.48026078984;13394.598162055154;13559.389827457591;13657.317134143452;14029.719405611626;11253;11429.371384573597;11465.14011449128;11474.942625287154;11628.883711163118;11267.647882254181;11359.659210223706;11431.657050288504;11474.368909710047;11529.308241505536 10:11:56 INFO - PROCESS | 4826 | __end_tp_report 10:11:56 INFO - PROCESS | 4826 | __start_cc_report 10:11:56 INFO - PROCESS | 4826 | _x_x_mozilla_cycle_collect,329 10:11:56 INFO - PROCESS | 4826 | __end_cc_report 10:11:56 INFO - PROCESS | 4826 | __startTimestamp1466442716334__endTimestamp 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | ------- Summary: start ------- 10:11:56 INFO - PROCESS | 4826 | Number of tests: 6 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | [#0] dojo.html Cycles:165 Average:5692.56 Median:5907.20 stddev:656.52 (11.1%) stddev-sans-first:631.55 10:11:56 INFO - PROCESS | 4826 | Values: 3317.9 3376.2 3401.7 3431.5 3432.9 5617.0 5670.7 5723.1 5726.0 5769.2 5683.2 5769.9 5774.1 5788.4 5791.2 5128.7 5186.8 5240.1 5268.6 5307.7 5089.9 5136.4 5356.1 5362.1 5366.4 5212.0 5245.1 5301.7 5320.7 5322.6 5212.3 5226.3 5226.6 5233.6 5238.1 5071.0 5127.3 5218.5 5232.6 5257.6 5448.9 5531.6 5594.7 5606.1 5610.3 6099.8 6134.0 6137.1 6141.6 6145.4 5972.7 6156.4 6171.9 6183.1 6189.4 5636.5 5649.7 5685.1 5715.2 5754.3 6268.5 6286.6 6293.0 6299.7 6308.0 6014.4 6024.1 6050.1 6050.9 6053.2 6137.6 6141.0 6143.4 6167.5 6187.8 6080.9 6121.2 6142.8 6153.8 6164.8 5900.1 6094.7 6112.7 6128.2 6130.9 4588.3 4588.3 4591.1 4610.5 4614.6 4107.4 4109.2 4114.2 4141.6 4148.1 5904.3 5906.4 5906.7 5948.4 5960.3 5933.5 6046.5 6052.9 6067.5 6130.1 5837.0 5881.4 5883.4 5886.6 5897.9 4908.1 5038.8 5083.3 5089.7 5104.2 6380.5 6384.9 6391.0 6405.0 6415.8 6162.9 6164.4 6166.4 6174.1 6175.0 6131.1 6361.1 6372.8 6443.5 6503.4 6042.6 6073.2 6081.8 6099.0 6100.9 6186.8 6187.7 6192.6 6193.7 6197.3 5774.9 5986.5 6044.3 6045.7 6080.9 5867.4 5955.3 5959.9 5961.2 5970.1 5690.7 5879.0 5891.5 5893.0 5904.0 6011.0 6091.8 6101.4 6126.9 6129.7 5905.9 5907.2 5935.0 5944.7 5964.3 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | [#1] ext.html Cycles:180 Average:58614.03 Median:40319.70 stddev:116807.06 (289.7%) stddev-sans-first:117053.71 10:11:56 INFO - PROCESS | 4826 | Values: 669.7 683.6 705.0 729.9 775.9 38527.4 40259.8 40379.6 40439.8 40473.8 40019.2 40704.6 40904.6 40910.6 41141.4 8578.1 8674.8 8716.1 8722.5 8763.7 8485.4 8652.7 8893.4 8906.2 8919.7 8895.2 8898.2 8901.2 8914.6 8934.4 8809.7 8826.2 8840.1 8843.4 8875.7 8795.2 9005.6 9024.7 9026.6 9027.1 40526.0 40761.0 41312.8 41383.8 43229.6 3661.3 3814.4 3851.6 4097.2 4373.7 31146.5 31348.9 31644.5 31701.7 31704.7 4553.0 4606.0 4627.1 4632.1 4643.4 321033.0 323027.0 324669.0 325279.0 325364.0 38846.4 39253.0 65399.7 66380.0 66441.0 37657.8 37850.6 37969.6 38208.4 38211.2 16296.5 16436.8 16437.5 16490.7 16493.5 13483.8 13682.9 13704.7 13719.2 13761.5 9218.3 9466.3 9494.7 9530.0 9565.2 3660.6 3673.4 3738.7 3747.6 3747.8 1120.6 1148.0 1188.8 1246.1 1273.0 33500.2 33894.0 33979.2 34156.5 34904.8 1228.8 1233.3 1237.9 1301.7 1331.0 17231.0 17500.0 17571.2 17693.3 17717.9 447116.0 554129.0 561555.0 572319.0 573041.0 62790.0 63075.1 63590.7 63827.0 64001.7 1452.1 1470.4 1487.5 1490.6 1578.5 33053.0 33847.5 34177.3 34323.7 34652.8 54129.7 54592.0 54639.0 54681.7 54865.5 419166.0 423554.0 424147.0 424901.0 427331.0 30508.0 31159.5 31177.1 31418.5 31431.4 49813.5 50273.0 50816.0 51091.0 51228.7 38889.2 38977.4 39255.2 39355.2 40254.2 37446.3 37686.2 40239.0 41696.8 41998.0 41871.8 41956.6 42615.4 42652.8 43023.0 36362.0 36520.8 36968.5 37124.0 37525.4 28522.7 29080.0 29218.0 29541.3 29573.0 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | [#2] jquery.html Cycles:180 Average:28660.89 Median:12951.91 stddev:79885.21 (616.8%) stddev-sans-first:80081.18 10:11:56 INFO - PROCESS | 4826 | Values: 423.5 428.1 431.0 434.5 440.1 18427.9 19214.9 19277.4 19574.6 20541.5 13024.9 13194.3 13754.5 18660.8 20511.7 5232.2 5405.2 5424.4 5454.3 5455.8 5366.5 5761.9 5770.1 5771.5 5787.0 5715.4 5720.3 5723.8 5726.6 5739.5 5350.1 5372.6 5388.1 5392.8 5394.9 5248.8 5255.0 5257.6 5264.4 5269.1 17723.4 23569.0 23854.2 23881.4 23940.8 2334.8 2570.7 2620.6 2849.1 3082.0 10914.7 12295.4 13046.5 14851.9 15036.6 1870.8 1925.4 2012.2 2108.3 2135.2 80025.6 80281.6 80935.6 81287.2 82480.6 10330.9 10441.6 10566.3 10731.5 10752.6 14779.9 14900.4 14901.1 14918.6 14945.9 8381.4 8442.3 8443.7 8543.2 8659.7 8385.8 8440.6 8449.5 8522.2 8633.6 4383.7 4445.2 4574.8 4775.8 4844.3 1861.0 1945.7 1958.1 1969.6 2037.7 1071.0 1157.2 1160.3 1173.4 1175.9 18860.8 19051.8 19346.1 19612.5 19920.9 1069.2 1071.2 1103.2 1107.3 1154.8 10807.5 10998.9 10999.3 11046.4 11197.0 419077.0 422248.0 431105.0 562695.0 562992.0 82241.0 88300.6 88475.6 90178.5 96238.5 1125.1 1168.4 1168.5 1171.8 1174.2 17481.6 17937.3 18024.5 18067.4 18377.2 37690.8 38162.0 41730.4 42351.8 43698.8 58233.7 58709.7 58959.1 59094.4 59419.7 8404.7 8703.7 8815.2 8854.9 8956.2 13507.3 13583.3 13612.5 13684.0 13752.4 8123.6 10413.1 11183.9 11217.8 11775.1 11863.6 11918.3 11962.0 12188.9 12196.9 11505.5 12005.4 12359.6 12648.2 12897.2 8374.8 8615.8 8626.0 9028.8 9323.6 11249.2 11999.6 12047.2 12456.6 12535.9 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | [#3] mootools.html Cycles:180 Average:5755.32 Median:4905.60 stddev:3179.92 (64.8%) stddev-sans-first:3172.69 10:11:56 INFO - PROCESS | 4826 | Values: 1491.1 1534.6 1781.8 1937.1 1966.8 8504.7 8699.3 8730.2 8792.6 8932.3 8902.8 8942.6 8986.8 9013.9 9015.0 2448.3 2488.7 2490.2 2493.3 2493.4 2471.4 2481.9 2494.2 2497.2 2497.8 2454.9 2458.6 2473.9 2479.2 2484.8 2425.7 2427.9 2428.7 2462.7 2464.9 2491.2 2493.9 2504.8 2522.8 2533.3 8770.9 8779.6 8793.8 8797.0 8799.3 5282.7 5396.2 5405.7 5417.4 5422.2 3495.3 3499.0 3561.6 3567.6 3577.7 1206.2 1283.6 1291.9 1303.3 1312.8 12290.9 12378.7 12382.1 12384.1 12438.3 4517.2 4617.6 4635.1 4652.2 4672.6 9929.4 9937.1 9938.9 9962.6 9978.8 5323.1 5389.2 5400.1 5400.5 5409.1 4690.0 4770.8 4812.7 4813.3 5001.6 3926.8 4025.9 4071.3 4132.4 4132.6 1201.6 1205.8 1211.8 1216.9 1232.4 940.5 1014.8 1026.7 1036.5 1041.6 5745.0 5763.8 5791.8 5831.0 5934.2 465.3 467.0 470.8 1067.9 1076.1 4034.6 4038.0 4047.0 4053.6 4082.1 10181.5 10377.2 10412.2 10417.9 10523.6 10262.0 10361.9 10379.1 10393.0 10406.3 8140.2 8352.1 8372.5 8383.2 8387.1 5863.4 5923.2 5982.5 6026.7 6144.2 9621.0 9632.8 9741.8 9802.9 9924.6 9767.6 9870.2 10045.4 10229.8 10313.1 7473.2 7529.1 7573.9 7666.1 7819.1 8266.5 8332.0 8335.5 8336.2 8393.4 7341.9 7461.6 7514.2 7547.0 7624.2 7001.9 7090.4 7098.8 7186.1 7195.7 6634.7 6680.1 6750.6 6757.8 6772.5 4997.9 5028.1 5052.5 5141.7 5194.1 5123.5 5123.6 5126.0 5174.1 5204.9 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | [#4] prototype.html Cycles:180 Average:5921.47 Median:6823.88 stddev:1818.41 (26.6%) stddev-sans-first:1774.82 10:11:56 INFO - PROCESS | 4826 | Values: 352.9 361.4 362.3 370.9 374.4 6580.3 6629.2 6708.5 6848.1 6881.2 6590.9 6655.7 6672.0 6673.6 6689.0 5022.3 5044.4 5072.2 5073.1 5075.9 5084.1 5086.2 5091.9 5092.2 5094.8 5040.9 5047.8 5048.8 5053.7 5057.9 4836.7 4970.6 5045.5 5048.3 5065.8 4281.7 4304.1 4312.2 4312.4 4315.0 6294.5 6309.9 6310.6 6312.9 6316.8 5803.5 5812.9 5826.4 5848.9 5882.9 7051.8 7063.4 7071.8 7075.9 7078.8 4696.3 4854.0 4868.0 4870.7 4881.8 7339.9 7353.5 7361.2 7394.6 7412.0 4897.8 4900.9 4903.9 4911.2 4927.2 4983.3 4994.4 4995.5 4998.1 4998.7 5833.7 5841.7 5850.4 5854.9 5859.7 6813.7 7045.4 7070.9 7076.0 7122.9 1753.9 1763.3 1767.9 1769.1 1775.8 1129.3 1134.3 1140.2 1152.5 1153.4 6830.2 6866.5 6876.3 6878.1 6885.4 7265.1 7274.3 7315.1 7324.6 7329.1 6818.8 6822.8 6824.9 6830.7 6832.8 3903.2 3916.2 3959.6 3962.1 3963.3 7515.8 7554.0 7561.9 7563.0 7578.2 7340.8 7370.3 7377.7 7398.4 7401.8 7492.3 7514.6 7520.3 7524.2 7574.0 7206.0 7265.6 7274.2 7283.6 7288.3 7259.9 7263.3 7325.6 7330.2 7331.7 7749.3 7802.4 7820.9 7826.5 7843.8 4953.8 4986.8 4997.0 5008.0 5020.3 7328.6 7350.4 7440.8 7451.0 7456.7 7186.5 7209.1 7213.1 7215.0 7235.1 7135.9 7172.7 7195.8 7197.3 7200.6 7036.2 7066.7 7067.4 7071.8 7082.8 6972.9 7151.0 7175.5 7236.3 7249.2 6878.1 7051.9 7080.4 7099.1 7111.0 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - PROCESS | 4826 | [#5] yui.html Cycles:180 Average:15621.36 Median:4756.73 stddev:17631.32 (370.7%) stddev-sans-first:17645.80 10:11:56 INFO - PROCESS | 4826 | Values: 831.7 860.5 884.2 918.1 946.6 16642.5 16988.0 16999.9 17011.1 17011.3 15543.0 15573.1 15647.2 15658.8 15743.3 832.8 851.0 863.7 875.3 891.4 748.7 824.8 873.5 879.7 919.9 944.4 954.5 960.6 961.3 964.5 921.5 946.5 952.4 954.4 956.9 696.4 696.5 698.9 701.0 701.6 15330.8 15369.3 15374.7 15393.4 15447.2 13981.7 14088.4 14095.3 14136.2 14228.8 11597.4 11659.8 11838.6 11868.2 11904.6 3932.0 3954.6 3975.1 4005.6 4076.3 55398.7 55441.4 55584.4 56282.4 56607.2 10949.1 10952.5 11375.7 11449.4 11454.5 19890.7 19925.3 19930.4 19951.3 20254.7 8548.0 8596.2 8671.7 8684.1 8718.3 4742.4 4771.1 4853.3 4866.8 4961.2 3552.7 3587.0 3592.7 3595.4 3604.7 627.4 647.2 648.8 650.7 660.1 771.9 792.2 814.6 834.8 841.6 9512.9 9821.1 10167.2 10209.5 10211.3 670.5 726.3 819.1 828.2 837.2 4556.0 4568.7 4827.0 4835.8 4863.6 60766.1 60950.0 61352.7 63094.0 63182.7 53827.7 54744.7 55249.0 55391.7 55595.4 49999.0 50922.0 51016.7 51045.0 51415.7 9192.9 9433.3 9618.0 9635.8 9712.6 37274.0 38187.8 39419.4 39511.4 42075.5 51152.5 51190.5 51556.5 51565.0 52555.5 12664.7 12836.9 12926.7 13016.8 13095.7 13778.4 13984.1 14008.4 14193.3 14277.5 13282.6 13367.0 13390.8 13411.0 13615.9 13130.0 13261.6 13448.1 13463.8 13483.9 12993.5 13394.6 13559.4 13657.3 14029.7 11253.0 11429.4 11465.1 11474.9 11628.9 11267.6 11359.7 11431.7 11474.4 11529.3 10:11:56 INFO - PROCESS | 4826 | -------- Summary: end -------- 10:11:56 INFO - PROCESS | 4826 | 10:11:56 INFO - TEST-INFO | 4826: exit 0 10:11:57 INFO - TEST-OK | dromaeo_css | took 1111230ms 10:11:57 INFO - TEST-START | kraken 10:11:57 INFO - operating with platform_type : linux_ 10:11:57 INFO - Initialising browser for kraken test... 10:11:57 INFO - TEST-INFO | started process 5069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDuMrMp/profile http://localhost:34425/getInfo.html) 10:12:01 INFO - PROCESS | 5069 | 10:12:01 INFO - PROCESS | 5069 | (process:5144): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:12:01 INFO - PROCESS | 5069 | __metrics Screen width/height:1600/1200 10:12:01 INFO - PROCESS | 5069 | colorDepth:24 10:12:01 INFO - PROCESS | 5069 | Browser inner width/height: 1024/697 10:12:01 INFO - PROCESS | 5069 | __metrics 10:12:02 ERROR - PROCESS | 5069 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 10:12:03 INFO - TEST-INFO | 5069: exit 0 10:12:03 INFO - Browser initialized. 10:12:03 INFO - Running cycle 1/1 for kraken test... 10:12:03 INFO - TEST-INFO | started process 5195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDuMrMp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:05 INFO - PROCESS | 5195 | 10:12:05 INFO - PROCESS | 5195 | (process:5263): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:12:15 INFO - PROCESS | 5195 | RSS: Main: 151154688 10:12:15 INFO - PROCESS | 5195 | 10:12:17 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34425/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:18 INFO - PROCESS | 5195 | RSS: Main: 156807168 10:12:18 INFO - PROCESS | 5195 | 10:12:21 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34425/tests/kraken/driver.html?testName=audio-dft) 10:12:22 INFO - PROCESS | 5195 | RSS: Main: 156254208 10:12:22 INFO - PROCESS | 5195 | 10:12:24 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34425/tests/kraken/driver.html?testName=audio-fft) 10:12:25 INFO - PROCESS | 5195 | RSS: Main: 156733440 10:12:25 INFO - PROCESS | 5195 | 10:12:27 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34425/tests/kraken/driver.html?testName=audio-oscillator) 10:12:28 INFO - PROCESS | 5195 | RSS: Main: 156999680 10:12:28 INFO - PROCESS | 5195 | 10:12:30 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:31 INFO - PROCESS | 5195 | RSS: Main: 156995584 10:12:31 INFO - PROCESS | 5195 | 10:12:33 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34425/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:34 INFO - PROCESS | 5195 | RSS: Main: 157741056 10:12:34 INFO - PROCESS | 5195 | 10:12:37 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34425/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:38 INFO - PROCESS | 5195 | RSS: Main: 157118464 10:12:38 INFO - PROCESS | 5195 | 10:12:41 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34425/tests/kraken/driver.html?testName=json-parse-financial) 10:12:41 INFO - PROCESS | 5195 | RSS: Main: 156827648 10:12:41 INFO - PROCESS | 5195 | 10:12:43 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:44 INFO - PROCESS | 5195 | RSS: Main: 156303360 10:12:44 INFO - PROCESS | 5195 | 10:12:45 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:46 INFO - PROCESS | 5195 | RSS: Main: 156438528 10:12:46 INFO - PROCESS | 5195 | 10:12:48 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:49 INFO - PROCESS | 5195 | RSS: Main: 156839936 10:12:49 INFO - PROCESS | 5195 | 10:12:51 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:52 INFO - PROCESS | 5195 | RSS: Main: 157331456 10:12:52 INFO - PROCESS | 5195 | 10:12:54 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:55 INFO - PROCESS | 5195 | RSS: Main: 157323264 10:12:55 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | Cycle 1(1): loaded http://localhost:34425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34425/tests/kraken/driver.html?testName=ai-astar) 10:12:57 INFO - PROCESS | 5195 | RSS: Main: 158654464 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | __start_tp_report 10:12:57 INFO - PROCESS | 5195 | _x_x_mozilla_page_load 10:12:57 INFO - PROCESS | 5195 | _x_x_mozilla_page_load_details 10:12:57 INFO - PROCESS | 5195 | |i|pagename|runs| 10:12:57 INFO - PROCESS | 5195 | |0;ai-astar;112;106;110;109;115;122;110;109;110;111 10:12:57 INFO - PROCESS | 5195 | |1;audio-beat-detection;149;126;160;182;127;152;159;127;189;127 10:12:57 INFO - PROCESS | 5195 | |2;audio-dft;162;162;162;164;164;162;162;162;161;160 10:12:57 INFO - PROCESS | 5195 | |3;audio-fft;75;76;74;178;76;73;76;85;156;76 10:12:57 INFO - PROCESS | 5195 | |4;audio-oscillator;93;92;155;92;92;93;150;93;93;149 10:12:57 INFO - PROCESS | 5195 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;118;117 10:12:57 INFO - PROCESS | 5195 | |6;imaging-darkroom;146;147;147;146;146;147;147;147;147;147 10:12:57 INFO - PROCESS | 5195 | |7;imaging-desaturate;95;94;95;98;95;96;96;95;95;96 10:12:57 INFO - PROCESS | 5195 | |8;json-parse-financial;58;59;55;58;55;56;55;75;55;54 10:12:57 INFO - PROCESS | 5195 | |9;json-stringify-tinderbox;58;58;58;58;59;58;57;57;58;58 10:12:57 INFO - PROCESS | 5195 | |10;stanford-crypto-aes;78;71;72;74;73;73;74;73;74;73 10:12:57 INFO - PROCESS | 5195 | |11;stanford-crypto-ccm;119;114;113;115;116;117;116;120;124;126 10:12:57 INFO - PROCESS | 5195 | |12;stanford-crypto-pbkdf2;161;156;161;156;155;161;158;156;158;154 10:12:57 INFO - PROCESS | 5195 | |13;stanford-crypto-sha256-iterative;65;66;67;69;67;65;64;66;65;65 10:12:57 INFO - PROCESS | 5195 | __end_tp_report 10:12:57 INFO - PROCESS | 5195 | __start_cc_report 10:12:57 INFO - PROCESS | 5195 | _x_x_mozilla_cycle_collect,860 10:12:57 INFO - PROCESS | 5195 | __end_cc_report 10:12:57 INFO - PROCESS | 5195 | __startTimestamp1466442777283__endTimestamp 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | ------- Summary: start ------- 10:12:57 INFO - PROCESS | 5195 | Number of tests: 14 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#0] ai-astar Cycles:10 Average:111.40 Median:110.50 stddev:4.38 (4.0%) stddev-sans-first:4.64 10:12:57 INFO - PROCESS | 5195 | Values: 112.0 106.0 110.0 109.0 115.0 122.0 110.0 109.0 110.0 111.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:155.50 stddev:23.32 (15.0%) stddev-sans-first:24.73 10:12:57 INFO - PROCESS | 5195 | Values: 149.0 126.0 160.0 182.0 127.0 152.0 159.0 127.0 189.0 127.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 10:12:57 INFO - PROCESS | 5195 | Values: 162.0 162.0 162.0 164.0 164.0 162.0 162.0 162.0 161.0 160.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:38.70 (50.9%) stddev-sans-first:40.39 10:12:57 INFO - PROCESS | 5195 | Values: 75.0 76.0 74.0 178.0 76.0 73.0 76.0 85.0 156.0 76.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.50 stddev:28.43 (30.7%) stddev-sans-first:29.46 10:12:57 INFO - PROCESS | 5195 | Values: 93.0 92.0 155.0 92.0 92.0 93.0 150.0 93.0 93.0 149.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:12:57 INFO - PROCESS | 5195 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 10:12:57 INFO - PROCESS | 5195 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:1.08 (1.1%) stddev-sans-first:1.13 10:12:57 INFO - PROCESS | 5195 | Values: 95.0 94.0 95.0 98.0 95.0 96.0 96.0 95.0 95.0 96.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:6.20 (10.9%) stddev-sans-first:6.58 10:12:57 INFO - PROCESS | 5195 | Values: 58.0 59.0 55.0 58.0 55.0 56.0 55.0 75.0 55.0 54.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 10:12:57 INFO - PROCESS | 5195 | Values: 58.0 58.0 58.0 58.0 59.0 58.0 57.0 57.0 58.0 58.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#10] stanford-crypto-aes Cycles:10 Average:73.50 Median:73.50 stddev:1.84 (2.5%) stddev-sans-first:1.00 10:12:57 INFO - PROCESS | 5195 | Values: 78.0 71.0 72.0 74.0 73.0 73.0 74.0 73.0 74.0 73.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:118.00 stddev:4.27 (3.6%) stddev-sans-first:4.51 10:12:57 INFO - PROCESS | 5195 | Values: 119.0 114.0 113.0 115.0 116.0 117.0 116.0 120.0 124.0 126.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:158.00 stddev:2.63 (1.7%) stddev-sans-first:2.49 10:12:57 INFO - PROCESS | 5195 | Values: 161.0 156.0 161.0 156.0 155.0 161.0 158.0 156.0 158.0 154.0 10:12:57 INFO - PROCESS | 5195 | 10:12:57 INFO - PROCESS | 5195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.50 10:12:57 INFO - PROCESS | 5195 | Values: 65.0 66.0 67.0 69.0 67.0 65.0 64.0 66.0 65.0 65.0 10:12:57 INFO - PROCESS | 5195 | -------- Summary: end -------- 10:12:57 INFO - PROCESS | 5195 | 10:12:58 INFO - TEST-INFO | 5195: exit 0 10:12:58 INFO - TEST-OK | kraken | took 61219ms 10:12:58 INFO - SUITE-END | took 1172s 10:12:58 INFO - Completed test suite (00:19:32) 10:12:58 INFO - javascript benchmark 10:12:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.9004629861106, 3376.172837654775, 3401.659834016598, 3431.519587257783, 3432.897013089607, 5617.01702202115, 5670.68811215383, 5723.141528770687, 5725.971370143144, 5769.1923130761725, 5683.232763576916, 5769.942300576993, 5774.105013722869, 5788.42115788422, 5791.160281759142, 5128.743562821863, 5186.818461353853, 5240.056789777838, 5268.631195816294, 5307.73461326934, 5089.949100508985, 5136.409312929024, 5356.143017117262, 5362.0616392131415, 5366.382865970424, 5212.035773381917, 5245.082110630643, 5301.655392399482, 5320.733963301839, 5322.627416080876, 5212.348456442964, 5226.268322434862, 5226.634135610509, 5233.581313494911, 5238.083335416287, 5071.0, 5127.307813445174, 5218.478152184789, 5232.607554433394, 5257.553107985826, 5448.891022179534, 5531.640443371209, 5594.748236329375, 5606.074997625387, 5610.298712660918, 6099.786507472261, 6133.969330153365, 6137.140800287963, 6141.570090093695, 6145.354737752561, 5972.6715030673295, 6156.415140561639, 6171.938280617182, 6183.103449999725, 6189.38106189382, 5636.4927156556105, 5649.745761440745, 5685.0619647758485, 5715.199872017921, 5754.251947246873, 6268.49852011838, 6286.622802631857, 6292.96166132583, 6299.6535190564955, 6308.0, 6014.398560143951, 6024.0662697282, 6050.092486127116, 6050.878982420415, 6053.182820319289, 6137.560853825989, 6141.0, 6143.354947730424, 6167.506599472032, 6187.752489900444, 6080.878382432326, 6121.234845644294, 6142.815715528542, 6153.784617538454, 6164.845878853064, 5900.144479050514, 6094.695265236721, 6112.716259964539, 6128.1837556712435, 6130.917941862977, 4588.2658774596575, 4588.334691469719, 4591.104734576726, 4610.469795973506, 4614.630829533629, 4107.383892416162, 4109.178164367138, 4114.238865809834, 4141.585841415835, 4148.0666849959125, 5904.3210030847, 5906.40935906406, 5906.704664766745, 5948.375420580864, 5960.284765828128, 5933.465988061095, 6046.516278697693, 6052.939470605325, 6067.544934129958, 6130.141780150782, 5837.0, 5881.411858814085, 5883.382244864313, 5886.58793884424, 5897.911531327033, 4908.092002979461, 5038.823641172541, 5083.288339632454, 5089.745512724349, 5104.183330667075, 6380.457661098766, 6384.872302554016, 6391.041343798374, 6405.03924411342, 6415.775447859396, 6162.907556386568, 6164.4143806339225, 6166.352532983972, 6174.073888916699, 6174.969125154345, 6131.101423540838, 6361.14124593174, 6372.808815735535, 6443.516736244706, 6503.382178693017, 6042.577019608585, 6073.240844894388, 6081.847953801191, 6099.0, 6100.908486372797, 6186.81439556814, 6187.721552530057, 6192.59748116371, 6193.721282542207, 6197.349278325711, 5774.913376299275, 5986.461218490357, 6044.274687037584, 6045.667488288186, 6080.939190608037, 5867.413258674099, 5955.315138758925, 5959.880802383841, 5961.165436838933, 5970.134330522137, 5690.743916523849, 5879.029960056714, 5891.49922256613, 5892.970535147297, 5903.970480147744, 6011.0, 6091.817245482643, 6101.359357267423, 6126.877462450815, 6129.695011270001, 5905.881882362242, 5907.202527658711, 5935.0, 5944.6730429826775, 5964.254468191476], "value": 5648.143655497306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.7007804858574, 683.5659356308743, 705.0305829484458, 729.91605965314, 775.9030121234846, 38527.42208866866, 40259.79870100649, 40379.59620403795, 40439.797801011024, 40473.79763101184, 40019.19961600766, 40704.59295407045, 40904.59095409045, 40910.59089409105, 41141.38287925676, 8578.099299573532, 8674.783130421727, 8716.08481109484, 8722.476651400904, 8763.737087887373, 8485.363597730164, 8652.653893844239, 8893.377463577552, 8906.153915378029, 8919.687810926587, 8895.243904268113, 8898.243649289785, 8901.15439033294, 8914.598843052077, 8934.4192627479, 8809.735707928772, 8826.161514656098, 8840.071792461795, 8843.380963332569, 8875.689350872688, 8795.164459376349, 9005.594748236344, 9024.684136055272, 9026.638934442615, 9027.097290270985, 40526.0, 40761.0, 41312.79343603293, 41383.793081034404, 43229.567704323184, 3661.3226553087766, 3814.370628846237, 3851.6340947609933, 4097.160082183145, 4373.693841431101, 31146.53280200776, 31348.902788402524, 31644.525332120036, 31701.682983170103, 31704.682953170402, 4553.0, 4606.0, 4627.14397836398, 4632.0967411354795, 4643.3963584733765, 321033.0, 323027.0, 324669.0, 325279.0, 325364.0, 38846.41730374047, 39253.0, 65399.673001634685, 66380.0, 66441.0, 37657.81171094127, 37850.621493785264, 37969.620303797165, 38208.426873596916, 38211.23577528434, 16296.511104666879, 16436.75344869828, 16437.506874793777, 16490.670186596442, 16493.505194844172, 13483.797743033861, 13682.863171368159, 13704.65738356529, 13719.245441500812, 13761.518346857813, 9218.262538996863, 9466.29002824791, 9494.715158545254, 9530.0, 9565.234781217487, 3660.5607327120915, 3673.3571624966057, 3738.738288319846, 3747.6065013173225, 3747.756395834262, 1120.5573798349606, 1147.9782993136116, 1188.8097904335266, 1246.1463897230426, 1273.0, 33500.16249593731, 33894.0, 33979.150521236676, 34156.48765268523, 34904.82547587246, 1228.8218208359738, 1233.340163012802, 1237.8824011718873, 1301.7201301720177, 1331.034999625264, 17231.0, 17500.0, 17571.209295581728, 17693.292268309382, 17717.911410442866, 447116.0, 554129.0, 561555.0, 572319.0, 573041.0, 62790.0, 63075.05387419192, 63590.682046590395, 63827.0, 64001.67999159975, 1452.0561634937164, 1470.375090586518, 1487.5314276003242, 1490.627343164209, 1578.4902005810816, 33053.0, 33847.492287616195, 34177.31645367029, 34323.656763432045, 34652.82673586616, 54129.72935135299, 54592.0, 54639.0, 54681.72659136679, 54865.45134548763, 419166.0, 423554.0, 424147.0, 424901.0, 427331.0, 30508.0, 31159.532607011366, 31177.064688059396, 31418.52872206873, 31431.371372571964, 49813.501864980884, 50273.0, 50816.0, 51091.0, 51228.74385628048, 38889.222215556096, 38977.41533876937, 39255.214895701356, 39355.212895742494, 40254.194916100925, 37446.2510749778, 37686.2462750749, 40239.0, 41696.79151604223, 41998.0, 41871.79064104782, 41956.58043419527, 42615.36076958786, 42652.78673606736, 43023.0, 36362.0, 36520.81739591285, 36968.45742198777, 37124.0, 37525.43711844379, 28522.714772852007, 29080.0, 29218.0, 29541.261468462602, 29573.0], "value": 19600.151625420272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.5235360219753, 428.0881721932284, 431.0, 434.5372178629759, 440.1263491968442, 18427.907860460695, 19214.903925480372, 19277.421677349685, 19574.608507829835, 20541.486462838435, 13024.869751302484, 13194.274314912676, 13754.518591849263, 18660.81339186608, 20511.692324615105, 5232.1628539433605, 5405.216243644689, 5424.403315635277, 5454.34547854256, 5455.781768729246, 5366.4633536646415, 5761.913571296413, 5770.076787713967, 5771.480566748992, 5787.0, 5715.428457154293, 5720.342160651516, 5723.799667011655, 5726.570507211955, 5739.454751798593, 5350.117230656956, 5372.597055220874, 5388.137897936351, 5392.757325920343, 5394.91907621386, 5248.8425347239645, 5255.0278198533015, 5257.553107985787, 5264.368275806889, 5269.077911365534, 17723.379681711078, 23569.0, 23854.16510422127, 23881.40296492584, 23940.76059239403, 2334.8132149428006, 2570.7043689975517, 2620.580707086876, 2849.088291746642, 3082.0, 10914.672559823219, 12295.385230738428, 13046.543370982065, 14851.851481485155, 15036.624084397869, 1870.7848597411337, 1925.4319975607089, 2012.154894944127, 2108.325335892515, 2135.2099723102397, 80025.59987200085, 80281.59859200726, 80935.59532202301, 81287.18712812796, 82480.58759706163, 10330.863605003444, 10441.634542790965, 10566.31318964265, 10731.463426828628, 10752.623658171926, 14779.852201478063, 14900.403983840743, 14901.1059336438, 14918.627034324012, 14945.925270373578, 8381.371397145238, 8442.282405995558, 8443.662253509914, 8543.188397102265, 8659.653613855375, 8385.790355241168, 8440.57797110142, 8449.450785699033, 8522.190391912758, 8633.568321583896, 4383.693141480129, 4445.155420470101, 4574.817007319736, 4775.808967641325, 4844.297576851407, 1860.9813901860807, 1945.7081437784163, 1958.1286327584373, 1969.5765410436825, 2037.7350944377433, 1070.9678709638724, 1157.1552766480515, 1160.3038177093845, 1173.4308860202796, 1175.8530183727034, 18860.811391885905, 19051.809481905282, 19346.129424175946, 19612.509687257934, 19920.90039549793, 1069.1660504806264, 1071.196602548089, 1103.2167161315394, 1107.2968664897687, 1154.8440960470398, 10807.513661885234, 10998.945005274922, 10999.34003959765, 11046.447677616086, 11197.048250898602, 419077.0, 422248.0, 431105.0, 562695.0, 562992.0, 82241.0, 88300.55849720711, 88475.55762221148, 90178.54910725405, 96238.51880740692, 1125.0999200639455, 1168.415792103931, 1168.5384273212203, 1171.84765980422, 1174.2484809721784, 17481.56296092608, 17937.282508699507, 18024.459266222035, 18067.367642132464, 18377.173027214074, 37690.811545943194, 38162.0, 41730.374044389966, 42351.788241058595, 43698.781506092266, 58233.70883145557, 58709.70645146918, 58959.115613266695, 59094.40905590889, 59419.702901485216, 8404.663813447394, 8703.695370661997, 8815.206631403205, 8854.867176992479, 8956.193942545202, 13507.324633768469, 13583.32083395846, 13612.523561675294, 13684.0, 13752.449902003807, 8123.634436450256, 10413.062824345845, 11183.888161118284, 11217.775644487228, 11775.116866235237, 11863.584774533196, 11918.344491052729, 11962.0, 12188.939055304667, 12196.878031219574, 11505.539778408769, 12005.39973001329, 12359.62921112368, 12648.241105533698, 12897.161684490478, 8374.790630234293, 8615.784605384915, 8626.0, 9028.774280643036, 9323.627054917728, 11249.1563132767, 11999.64001079969, 12047.156699030984, 12456.564020259248, 12535.93732031334], "value": 9381.63186439004, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.1276903011737, 1534.6010037390283, 1781.8396344329017, 1937.060525645061, 1966.783653798081, 8504.744857654272, 8699.260562852158, 8730.214280714743, 8792.604332805024, 8932.285417166628, 8902.77743056424, 8942.64229430822, 8986.775330616721, 9013.909860901389, 9014.954925225366, 2448.2655203438985, 2488.6764720586298, 2490.2155820916355, 2493.326801763523, 2493.4015836199364, 2471.406862353031, 2481.8634975076366, 2494.2018554062706, 2497.2008957133726, 2497.7627125423055, 2454.9140780072703, 2458.557459657261, 2473.9010439582394, 2479.2066538707622, 2484.813638977075, 2425.6967879015124, 2427.9271621851285, 2428.672129262545, 2462.7167875694345, 2464.864432456214, 2491.190363131989, 2493.8628375439343, 2504.8371855829314, 2522.7603377679093, 2533.3033415810614, 8770.868436973387, 8779.64881404743, 8793.824123517557, 8797.0, 8799.29605631548, 5282.709450980195, 5396.244525766396, 5405.675659460445, 5417.404085550586, 5422.15956526739, 3495.2659941412335, 3498.9825050874583, 3561.5904171020406, 3567.571891373052, 3577.695895848856, 1206.179797737547, 1283.570004048645, 1291.9289439080846, 1303.3157592264042, 1312.822768926202, 12290.938545307306, 12378.690532736573, 12382.133250672456, 12384.071194660346, 12438.315892625902, 4517.186906356887, 4617.607503362185, 4635.096156249499, 4652.232381657056, 4672.579467847842, 9929.404235745878, 9937.10566049059, 9938.900610993798, 9962.601495940226, 9978.800423991624, 5323.0684630190335, 5389.218563308298, 5400.054990376669, 5400.459954004568, 5409.080456322435, 4690.038542098861, 4770.833020844254, 4812.735299558488, 4813.302071199656, 5001.599872010231, 3926.784026878492, 4025.939610905839, 4071.307877660805, 4132.40080188377, 4132.628063474302, 1201.6214892308894, 1205.8492688413949, 1211.7818792617413, 1216.8865488078309, 1232.4022848918446, 940.5062342270226, 1014.8021135878433, 1026.6560702164709, 1036.4558606731375, 1041.5833666533447, 5745.0, 5763.7982670606325, 5791.7683292667825, 5831.008728516163, 5934.228550288435, 465.27184955544465, 466.9766511674471, 470.7904982282851, 1067.8665166854144, 1076.0791986304566, 4034.576369481221, 4038.0, 4047.0, 4053.574374690615, 4082.142750022469, 10181.490925453698, 10377.16982641402, 10412.219083568763, 10417.895821041844, 10523.579056837641, 10261.95434481521, 10361.896381036244, 10379.06588407047, 10393.0, 10406.323588966692, 8140.185981401813, 8352.081271060179, 8372.497650141011, 8383.245507904317, 8387.077421483631, 5863.442972917566, 5923.170756094064, 5982.49148822355, 6026.668533230714, 6144.201253836973, 9621.0, 9632.807343853225, 9741.756456088655, 9802.852957205505, 9924.553395097093, 9767.60929562838, 9870.210383169186, 10045.447500387549, 10229.84655230187, 10313.1233845124, 7473.215312392121, 7529.096508419025, 7573.9242607573215, 7666.080070391588, 7819.0617125945255, 8266.462679925786, 8332.04181519133, 8335.49987000782, 8336.208060234268, 8393.370497212856, 7341.853162936604, 7461.589612571361, 7514.223565075023, 7547.0, 7624.199459056941, 7001.929980700332, 7090.361867431956, 7098.787036388917, 7186.1376634804155, 7195.676194571152, 6634.701438435185, 6680.0647909291765, 6750.561213521106, 6757.831054223684, 6772.492063095189, 4997.900041999067, 5028.094942910311, 5052.545270925634, 5141.665791723526, 5194.117000109914, 5123.462036486116, 5123.615728820428, 5126.0, 5174.120399532013, 5204.921926171035], "value": 4648.2886520689, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.85003873353816, 361.3838405518591, 362.34234863722344, 370.9035650730809, 374.3579760710383, 6580.309067547911, 6629.204495460552, 6708.463322934166, 6848.0755098061745, 6881.174259088903, 6590.934090659092, 6655.667216639161, 6672.0, 6673.566218195814, 6688.96655516723, 5022.271770593262, 5044.419891712445, 5072.2391641253835, 5073.086844368012, 5075.898482030358, 5084.135696931512, 5086.237064440345, 5091.949080509203, 5092.185250359925, 5094.847154585368, 5040.949590504085, 5047.798088076491, 5048.7980480780725, 5053.696778193302, 5057.924131138036, 4836.661433699643, 4970.577500912426, 5045.495450454961, 5048.268001139832, 5065.822696205633, 4281.657467402601, 4304.074623955865, 4312.159128969852, 4312.417823593806, 4314.978425107885, 6294.464970477515, 6309.936900630981, 6310.6213627182515, 6312.936870631327, 6316.778912738078, 5803.5357171426185, 5812.912806307909, 5826.388229235911, 5848.853778655525, 5882.852928676774, 7051.753188638373, 7063.434925205971, 7071.7878463646175, 7075.929240707578, 7078.823029424254, 4696.342512048316, 4854.0, 4867.951320486821, 4870.732109733964, 4881.780319885614, 7339.853202935911, 7353.522021068614, 7361.190269070452, 7394.55632662042, 7411.999380083674, 4897.755112244445, 4900.901981960412, 4903.8528844134735, 4911.18965370717, 4927.236278376786, 4983.252512123138, 4994.425641051253, 4995.450500444948, 4998.100341938413, 4998.725070121178, 5833.67914764692, 5841.707914604252, 5850.4149585042005, 5854.941450585525, 5859.707014649251, 6813.659317034128, 7045.365917067386, 7070.92929070713, 7075.964620176969, 7122.928770712227, 1753.9123043848012, 1763.2506184871636, 1767.8939263644222, 1769.133124768854, 1775.849052830498, 1129.305477131558, 1134.3194083549804, 1140.1505878120688, 1152.458344578047, 1153.377176324792, 6830.214525329551, 6866.485013623898, 6876.312368763083, 6878.071460352889, 6885.380315771505, 7265.09186351706, 7274.345308922222, 7315.122185337687, 7324.560526368435, 7329.083864516935, 6818.761343352959, 6822.829429264308, 6824.931750682529, 6830.726770929206, 6832.829179270459, 3903.1803321302277, 3916.2167566486814, 3959.6436320731273, 3962.0887195945093, 3963.2667956428154, 7515.820412080436, 7554.0, 7561.886571701429, 7563.0, 7578.204288549733, 7340.779776606711, 7370.262973702587, 7377.668004939791, 7398.4081273497995, 7401.8149546261775, 7492.325690687864, 7514.632890639431, 7520.323170914644, 7524.172341042481, 7573.97751303578, 7206.0, 7265.564066156047, 7274.236205198378, 7283.6358182089625, 7288.3076107769675, 7259.891101633374, 7263.273672632695, 7325.560466372035, 7330.193678695446, 7331.670074846538, 7749.302562769378, 7802.375809935078, 7820.921790782019, 7826.530408175528, 7843.84312313762, 4953.826616068421, 4986.775595098302, 4996.975015124901, 5008.0, 5020.347354843847, 7328.599327168142, 7350.411967042731, 7440.813979650336, 7450.962745186456, 7456.66445009965, 7186.532875363085, 7209.134903811576, 7213.062301900719, 7215.025971493781, 7235.095613048369, 7135.928640713526, 7172.677229524579, 7195.784126476214, 7197.316254955771, 7200.603966781878, 7036.155661320674, 7066.681999310146, 7067.363937245673, 7071.82320441993, 7082.752103676346, 6972.860542789217, 7151.0, 7175.46184036189, 7236.276372362721, 7249.202587715453, 6878.105846239957, 7051.894221586577, 7080.362767350963, 7099.148102227766, 7110.964445177741], "value": 5322.024981999771, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.713058994647, 860.4837097741354, 884.1556313720398, 918.0544039639171, 946.64629579701, 16642.500724978254, 16988.0, 16999.915000424997, 17011.064391458465, 17011.319547218096, 15542.989705669152, 15573.065616063015, 15647.217639118027, 15658.84341156588, 15743.291551880164, 832.7834762961613, 850.9914900850974, 863.6890719341033, 875.3434923807145, 891.3760367742574, 748.6593599912027, 824.8309096635176, 873.4977388001893, 879.6525372477868, 919.9264058875308, 944.3908678902104, 954.4559601027418, 960.5869476125264, 961.293449314753, 964.5418426247511, 921.5023887100991, 946.4557879219442, 952.4047470331043, 954.370115723619, 956.8564715292727, 696.355870819495, 696.4532841719276, 698.8776964031325, 701.039575781178, 701.6491754122939, 15330.846691533054, 15369.308381122877, 15374.692506149815, 15393.384264629512, 15447.227638618137, 13981.720365592733, 14088.436462541486, 14095.295235238196, 14136.22250776207, 14228.786568201485, 11597.409068261086, 11659.766804663945, 11838.585649502313, 11868.228565143238, 11904.642860714192, 3932.0, 3954.604539546051, 3975.125472396097, 4005.619466150711, 4076.2662720710555, 55398.72300638471, 55441.44558554443, 55584.44415555833, 56282.43717562854, 56607.15089273705, 10949.124070074375, 10952.507137178845, 11375.658730238107, 11449.427528623535, 11454.541818327174, 19890.70163947542, 19925.302614408425, 19930.402087937386, 19951.301704440273, 20254.69617955732, 8548.0, 8596.226339629338, 8671.6531338747, 8684.131586841266, 8718.346124040723, 4742.359781429532, 4771.093492236464, 4853.296272040534, 4866.78099485524, 4961.181405068123, 3552.7157827374267, 3587.0494319005484, 3592.6586974237407, 3595.442706380515, 3604.675579197885, 627.350692033752, 647.2071712152575, 648.844277373427, 650.7331993882485, 660.1154453032863, 771.9498232614862, 792.2275781113368, 814.5723495164967, 834.8163404051099, 841.6086519768214, 9512.90487095134, 9821.084888446685, 10167.186625069977, 10209.489525523843, 10211.336263143021, 670.4669787518934, 726.2628432141381, 819.0989911097864, 828.1511450762896, 837.1544739812833, 4555.9772201138785, 4568.748718820497, 4826.95173048265, 4835.782389792468, 4863.635227357891, 60766.08850867241, 60950.0, 61352.69323653353, 63094.0, 63182.68408658019, 53827.730861345444, 54744.72627636836, 55249.0, 55391.72304138453, 55595.44404555984, 49999.0, 50922.0, 51016.74491627592, 51045.0, 51415.74292128516, 9192.862107068533, 9433.339666223574, 9617.997660702455, 9635.807283854423, 9712.562934667816, 37274.0, 38187.80906095452, 39419.40870886997, 39511.407328889516, 42075.47547147181, 51152.48847511477, 51190.48809512006, 51556.484435155166, 51565.0, 52555.47444525506, 12664.74670506603, 12836.87163128394, 12926.741465170831, 13016.8047479286, 13095.738085238052, 13778.379972901042, 13984.091034082752, 14008.369623367176, 14193.290335482978, 14277.500287489887, 13282.601521954357, 13367.0, 13390.799138012742, 13411.0, 13615.863841361459, 13130.015248856183, 13261.602151935458, 13448.1258718183, 13463.798043029557, 13483.865161348653, 12993.48026078984, 13394.598162055154, 13559.389827457591, 13657.317134143452, 14029.719405611626, 11253.0, 11429.371384573597, 11465.14011449128, 11474.942625287154, 11628.883711163118, 11267.647882254181, 11359.659210223706, 11431.657050288504, 11474.368909710047, 11529.308241505536], "value": 7212.462813509964, "unit": "score"}], "name": "dromaeo_css", "value": 7550.727018829172, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 109.0, 115.0, 122.0, 110.0, 109.0, 110.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 160.0, 182.0, 127.0, 152.0, 159.0, 127.0, 189.0, 127.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 164.0, 162.0, 162.0, 162.0, 161.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 178.0, 76.0, 73.0, 76.0, 85.0, 156.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 155.0, 92.0, 92.0, 93.0, 150.0, 93.0, 93.0, 149.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 98.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 55.0, 58.0, 55.0, 56.0, 55.0, 75.0, 55.0, 54.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 58.0, 59.0, 58.0, 57.0, 57.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 72.0, 74.0, 73.0, 73.0, 74.0, 73.0, 74.0, 73.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 113.0, 115.0, 116.0, 117.0, 116.0, 120.0, 124.0, 126.0], "value": 118.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 161.0, 156.0, 155.0, 161.0, 158.0, 156.0, 158.0, 154.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 69.0, 67.0, 65.0, 64.0, 66.0, 65.0, 65.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1518.3000000000002, "alertThreshold": 2.0}]} 10:12:58 INFO - Return code: 0 10:12:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:12:58 ERROR - # TBPL SUCCESS # 10:12:58 INFO - Running post-action listener: _resource_record_post_action 10:12:58 INFO - Running post-run listener: _resource_record_post_run 10:12:59 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 425984; Write bytes: 214921216; Read time: 56; Write time: 322864 10:12:59 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 1396736; Read time: 0; Write time: 1536 10:12:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 425984; Write bytes: 213524480; Read time: 56; Write time: 321328 10:12:59 INFO - Running post-run listener: _upload_blobber_files 10:12:59 INFO - Blob upload gear active. 10:12:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:12:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:12:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:12:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:13:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:13:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:13:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:13:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:00 INFO - (blobuploader) - INFO - Done attempting. 10:13:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:13:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:13:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:13:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:13:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:13:01 INFO - (blobuploader) - INFO - Done attempting. 10:13:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:13:01 INFO - Return code: 0 10:13:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:13:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:13:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6867a675f8815a4c81c87c1ffe9f6490018833bf5d66b68a8ea1bdfb5c243bbe160df1558e76218d48d40bffa9db5d3293a829e0df72ce324acead7867c80e31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a877ad9ad1256833e4bce11c206cce843cec428a8d8b5f9d0b266b519780d7f398c5807f50dffa5242307541d7eebecece8bed2c3d498cfdfc6039963757e79"} 10:13:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:13:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:13:01 INFO - Contents: 10:13:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6867a675f8815a4c81c87c1ffe9f6490018833bf5d66b68a8ea1bdfb5c243bbe160df1558e76218d48d40bffa9db5d3293a829e0df72ce324acead7867c80e31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a877ad9ad1256833e4bce11c206cce843cec428a8d8b5f9d0b266b519780d7f398c5807f50dffa5242307541d7eebecece8bed2c3d498cfdfc6039963757e79"} 10:13:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:13:01 INFO - Copying logs to upload dir... 10:13:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:13:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.492047 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-20 10:13:01.610837) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 10:13:01.614104) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1466440725.976668-303672476 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/6867a675f8815a4c81c87c1ffe9f6490018833bf5d66b68a8ea1bdfb5c243bbe160df1558e76218d48d40bffa9db5d3293a829e0df72ce324acead7867c80e31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a877ad9ad1256833e4bce11c206cce843cec428a8d8b5f9d0b266b519780d7f398c5807f50dffa5242307541d7eebecece8bed2c3d498cfdfc6039963757e79"} build_url:https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/EhRjyXnZRJaBVrAqdMet_A/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/6867a675f8815a4c81c87c1ffe9f6490018833bf5d66b68a8ea1bdfb5c243bbe160df1558e76218d48d40bffa9db5d3293a829e0df72ce324acead7867c80e31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a877ad9ad1256833e4bce11c206cce843cec428a8d8b5f9d0b266b519780d7f398c5807f50dffa5242307541d7eebecece8bed2c3d498cfdfc6039963757e79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-20 10:13:01.643482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:13:01.643875) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1466440725.976668-303672476 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-20 10:13:01.727584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 10:13:01.728127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-20 10:13:01.728533) ========= ========= Total master_lag: 0.19 =========