builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1465290323.47 results: success (0) buildid: 20160606194329 builduid: 3d31ab4f42854c829e06ac6160cc676b revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.470202) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.470730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.471051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.483938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.484375) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:05:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.3M=0s 2016-06-07 02:05:23 (33.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145976 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.657534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.657918) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.086241 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.758290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:23.759046) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --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 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --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=74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:05:23,813 truncating revision to first 12 chars 2016-06-07 02:05:23,813 Setting DEBUG logging. 2016-06-07 02:05:23,813 attempt 1/10 2016-06-07 02:05:23,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1f9f6bdee31c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 02:05:24,172 unpacking tar archive at: mozilla-beta-1f9f6bdee31c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.698234 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:24.476574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:24.477342) ========= script_repo_revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:24.478282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:24.478925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:05:24.491153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-07 02:05:24.491478) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:24 INFO - MultiFileLogger online at 20160607 02:05:24 in /builds/slave/test 02:05:24 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 02:05:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:24 INFO - {'append_to_log': False, 02:05:24 INFO - 'base_work_dir': '/builds/slave/test', 02:05:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:05:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:24 INFO - 'branch': 'Mozilla-Beta', 02:05:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:24 INFO - 'config_files': ('talos/linux_config.py',), 02:05:24 INFO - 'default_actions': ('clobber', 02:05:24 INFO - 'read-buildbot-config', 02:05:24 INFO - 'download-and-extract', 02:05:24 INFO - 'populate-webroot', 02:05:24 INFO - 'create-virtualenv', 02:05:24 INFO - 'install', 02:05:24 INFO - 'run-tests'), 02:05:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:24 INFO - 'download_minidump_stackwalk': True, 02:05:24 INFO - 'download_symbols': 'ondemand', 02:05:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:24 INFO - 'installer_path': 'installer.exe', 02:05:24 INFO - 'log_level': 'info', 02:05:24 INFO - 'log_name': 'talos', 02:05:24 INFO - 'log_to_console': True, 02:05:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:24 INFO - 'opt_config_files': (), 02:05:24 INFO - 'pip_index': False, 02:05:24 INFO - 'sps_profile': False, 02:05:24 INFO - 'sps_profile_interval': 0, 02:05:24 INFO - 'suite': 'dromaeojs-e10s', 02:05:24 INFO - 'system_bits': '32', 02:05:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:24 INFO - 'title': 'talos-linux64-ix-042', 02:05:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:24 INFO - 'use_talos_json': True, 02:05:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:24 INFO - 'work_dir': 'build'} 02:05:24 INFO - ##### 02:05:24 INFO - ##### Running clobber step. 02:05:24 INFO - ##### 02:05:24 INFO - Running pre-action listener: _resource_record_pre_action 02:05:24 INFO - Running main action method: clobber 02:05:24 INFO - rmtree: /builds/slave/test/build 02:05:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:32 INFO - Running post-action listener: _resource_record_post_action 02:05:32 INFO - ##### 02:05:32 INFO - ##### Running read-buildbot-config step. 02:05:32 INFO - ##### 02:05:32 INFO - Running pre-action listener: _resource_record_pre_action 02:05:32 INFO - Running main action method: read_buildbot_config 02:05:32 INFO - Using buildbot properties: 02:05:32 INFO - { 02:05:32 INFO - "project": "", 02:05:32 INFO - "product": "firefox", 02:05:32 INFO - "script_repo_revision": "production", 02:05:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 02:05:32 INFO - "repository": "", 02:05:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 02:05:32 INFO - "buildid": "20160606194329", 02:05:32 INFO - "pgo_build": "True", 02:05:32 INFO - "basedir": "/builds/slave/test", 02:05:32 INFO - "buildnumber": 134, 02:05:32 INFO - "slavename": "talos-linux64-ix-042", 02:05:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:05:32 INFO - "platform": "ubuntu64_hw", 02:05:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:05:32 INFO - "branch": "mozilla-beta", 02:05:32 INFO - "repo_path": "releases/mozilla-beta", 02:05:32 INFO - "revision": "1f9f6bdee31c14fd5a39485e8ae326de2928ef7d", 02:05:32 INFO - "stage_platform": "linux64-pgo", 02:05:32 INFO - "builduid": "3d31ab4f42854c829e06ac6160cc676b", 02:05:32 INFO - "slavebuilddir": "test" 02:05:32 INFO - } 02:05:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 02:05:32 INFO - Running post-action listener: _resource_record_post_action 02:05:32 INFO - ##### 02:05:32 INFO - ##### Running download-and-extract step. 02:05:32 INFO - ##### 02:05:32 INFO - Running pre-action listener: _resource_record_pre_action 02:05:32 INFO - Running main action method: download_and_extract 02:05:32 INFO - mkdir: /builds/slave/test/build/tests 02:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:32 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:33 INFO - Downloaded 1327 bytes. 02:05:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:05:33 INFO - Using the following test package requirements: 02:05:33 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:05:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:05:33 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 02:05:33 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'jsshell-linux-x86_64.zip'], 02:05:33 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:05:33 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:05:33 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 02:05:33 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 02:05:33 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:05:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:05:33 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:05:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:05: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')]} 02:05:33 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:05:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:05:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:34 INFO - Downloaded 24176679 bytes. 02:05:34 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'] 02:05:34 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 02:05:36 INFO - Return code: 0 02:05:36 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 02:05:36 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')]} 02:05:36 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:41 INFO - Downloaded 24176679 bytes. 02:05:41 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'] 02:05:41 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 02:05:45 INFO - Return code: 0 02:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:45 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:05:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:05:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:05:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:48 INFO - Downloaded 10840145 bytes. 02:05:48 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'] 02:05:48 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 02:05:48 INFO - Return code: 0 02:05:48 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')]} 02:05:48 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/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 02:05:51 INFO - Downloaded 55996763 bytes. 02:05:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:05:51 INFO - mkdir: /builds/slave/test/properties 02:05:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:05:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:05:52 INFO - Contents: 02:05:52 INFO - build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:05:52 INFO - Running post-action listener: _resource_record_post_action 02:05:52 INFO - Running post-action listener: set_extra_try_arguments 02:05:52 INFO - ##### 02:05:52 INFO - ##### Running populate-webroot step. 02:05:52 INFO - ##### 02:05:52 INFO - Running pre-action listener: _resource_record_pre_action 02:05:52 INFO - Running main action method: populate_webroot 02:05:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:05:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:05:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:05:52 INFO - '--tppagecycles', 02:05:52 INFO - '7'], 02:05:52 INFO - 'tests': ['tsvgm']}}, 02:05:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:05:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:05:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:05:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['damp', 'tps']}, 02:05:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'tests': ['damp', 'tps']}, 02:05:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['dromaeo_dom']}, 02:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:05:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['a11yr', 02:05:52 INFO - 'ts_paint', 02:05:52 INFO - 'tpaint', 02:05:52 INFO - 'sessionrestore', 02:05:52 INFO - 'sessionrestore_no_auto_restore', 02:05:52 INFO - 'tabpaint']}, 02:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:05:52 INFO - 'ts_paint', 02:05:52 INFO - 'tpaint', 02:05:52 INFO - 'sessionrestore', 02:05:52 INFO - 'sessionrestore_no_auto_restore', 02:05:52 INFO - 'tabpaint']}, 02:05:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:05:52 INFO - 'ts_paint', 02:05:52 INFO - 'tpaint', 02:05:52 INFO - 'sessionrestore', 02:05:52 INFO - 'sessionrestore_no_auto_restore', 02:05:52 INFO - 'tabpaint']}, 02:05:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:05:52 INFO - 'ts_paint', 02:05:52 INFO - 'tpaint', 02:05:52 INFO - 'sessionrestore', 02:05:52 INFO - 'sessionrestore_no_auto_restore', 02:05:52 INFO - 'tabpaint']}, 02:05:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['a11yr', 02:05:52 INFO - 'ts_paint', 02:05:52 INFO - 'tpaint', 02:05:52 INFO - 'sessionrestore', 02:05:52 INFO - 'sessionrestore_no_auto_restore', 02:05:52 INFO - 'tabpaint']}, 02:05:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['a11yr', 02:05:52 INFO - 'ts_paint', 02:05:52 INFO - 'tpaint', 02:05:52 INFO - 'sessionrestore', 02:05:52 INFO - 'sessionrestore_no_auto_restore', 02:05:52 INFO - 'tabpaint']}, 02:05:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['tsvgx', 02:05:52 INFO - 'tsvgr_opacity', 02:05:52 INFO - 'tart', 02:05:52 INFO - 'tscrollx', 02:05:52 INFO - 'cart']}, 02:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:05:52 INFO - 'tsvgr_opacity', 02:05:52 INFO - 'tart', 02:05:52 INFO - 'tscrollx', 02:05:52 INFO - 'cart']}, 02:05:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'talos_options': ['--disable-e10s'], 02:05:52 INFO - 'tests': ['tp5o']}, 02:05:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'tests': ['tp5o']}, 02:05:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'talos_options': ['--disable-e10s', 02:05:52 INFO - '--xperf_path', 02:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:52 INFO - 'tests': ['tp5n']}, 02:05:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:52 INFO - 'talos_options': ['--xperf_path', 02:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:52 INFO - 'tests': ['tp5n']}}, 02:05:52 INFO - 'talos.zip': {'path': '', 02:05:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:05:52 INFO - Running post-action listener: _resource_record_post_action 02:05:52 INFO - ##### 02:05:52 INFO - ##### Running create-virtualenv step. 02:05:52 INFO - ##### 02:05:52 INFO - Running pre-action listener: _resource_record_pre_action 02:05:52 INFO - Running main action method: create_virtualenv 02:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:05:52 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 02:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:05:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:05:53 INFO - Using real prefix '/usr' 02:05:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:05:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:05:55 INFO - Installing pip.................done. 02:05:55 INFO - Return code: 0 02:05:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:05:55 INFO - Using env: {'DISPLAY': ':0', 02:05:55 INFO - 'HOME': '/home/cltbld', 02:05:55 INFO - 'LANG': 'en_US.UTF-8', 02:05:55 INFO - 'LANGUAGE': 'en_US:en', 02:05:55 INFO - 'LOGNAME': 'cltbld', 02:05:55 INFO - 'MAIL': '/var/mail/cltbld', 02:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:55 INFO - 'MOZ_NO_REMOTE': '1', 02:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:55 INFO - 'NO_EM_RESTART': '1', 02:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:55 INFO - 'PWD': '/builds/slave/test', 02:05:55 INFO - 'SHELL': '/bin/bash', 02:05:55 INFO - 'SHLVL': '1', 02:05:55 INFO - 'TERM': 'linux', 02:05:55 INFO - 'TMOUT': '86400', 02:05:55 INFO - 'USER': 'cltbld', 02:05:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:55 INFO - '_': '/tools/buildbot/bin/python'} 02:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:56 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 02:05:56 INFO - Cleaning up... 02:05:56 INFO - Return code: 0 02:05:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:05:56 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')]} 02:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:56 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')]} 02:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:56 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 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:05:56 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 02:05:56 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 02:05:56 INFO - Using env: {'DISPLAY': ':0', 02:05:56 INFO - 'HOME': '/home/cltbld', 02:05:56 INFO - 'LANG': 'en_US.UTF-8', 02:05:56 INFO - 'LANGUAGE': 'en_US:en', 02:05:56 INFO - 'LOGNAME': 'cltbld', 02:05:56 INFO - 'MAIL': '/var/mail/cltbld', 02:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:56 INFO - 'MOZ_NO_REMOTE': '1', 02:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:05:56 INFO - 'NO_EM_RESTART': '1', 02:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:56 INFO - 'PWD': '/builds/slave/test', 02:05:56 INFO - 'SHELL': '/bin/bash', 02:05:56 INFO - 'SHLVL': '1', 02:05:56 INFO - 'TERM': 'linux', 02:05:56 INFO - 'TMOUT': '86400', 02:05:56 INFO - 'USER': 'cltbld', 02:05:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:56 INFO - '_': '/tools/buildbot/bin/python'} 02:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:56 INFO - Downloading/unpacking psutil>=0.7.1 02:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:58 INFO - Installing collected packages: psutil 02:05:58 INFO - Running setup.py install for psutil 02:05:58 INFO - building 'psutil._psutil_linux' extension 02:05:58 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 02:06:00 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 02:06:00 INFO - building 'psutil._psutil_posix' extension 02:06:00 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 02:06:00 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 02:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:00 INFO - Successfully installed psutil 02:06:00 INFO - Cleaning up... 02:06:00 INFO - Return code: 0 02:06:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:00 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 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:06:00 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 02:06:00 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 02:06:00 INFO - Using env: {'DISPLAY': ':0', 02:06:00 INFO - 'HOME': '/home/cltbld', 02:06:00 INFO - 'LANG': 'en_US.UTF-8', 02:06:00 INFO - 'LANGUAGE': 'en_US:en', 02:06:00 INFO - 'LOGNAME': 'cltbld', 02:06:00 INFO - 'MAIL': '/var/mail/cltbld', 02:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:00 INFO - 'MOZ_NO_REMOTE': '1', 02:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:00 INFO - 'NO_EM_RESTART': '1', 02:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:00 INFO - 'PWD': '/builds/slave/test', 02:06:00 INFO - 'SHELL': '/bin/bash', 02:06:00 INFO - 'SHLVL': '1', 02:06:00 INFO - 'TERM': 'linux', 02:06:00 INFO - 'TMOUT': '86400', 02:06:00 INFO - 'USER': 'cltbld', 02:06:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:00 INFO - '_': '/tools/buildbot/bin/python'} 02:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:06:00 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 02:06:00 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 02:06:00 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 02:06:00 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 02:06:00 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 02:06:00 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 02:06:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:06:02 INFO - Installing collected packages: mozsystemmonitor 02:06:02 INFO - Running setup.py install for mozsystemmonitor 02:06:02 INFO - Successfully installed mozsystemmonitor 02:06:02 INFO - Cleaning up... 02:06:02 INFO - Return code: 0 02:06:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:02 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 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:06:02 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 02:06:02 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 02:06:02 INFO - Using env: {'DISPLAY': ':0', 02:06:02 INFO - 'HOME': '/home/cltbld', 02:06:02 INFO - 'LANG': 'en_US.UTF-8', 02:06:02 INFO - 'LANGUAGE': 'en_US:en', 02:06:02 INFO - 'LOGNAME': 'cltbld', 02:06:02 INFO - 'MAIL': '/var/mail/cltbld', 02:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:02 INFO - 'MOZ_NO_REMOTE': '1', 02:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:02 INFO - 'NO_EM_RESTART': '1', 02:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:02 INFO - 'PWD': '/builds/slave/test', 02:06:02 INFO - 'SHELL': '/bin/bash', 02:06:02 INFO - 'SHLVL': '1', 02:06:02 INFO - 'TERM': 'linux', 02:06:02 INFO - 'TMOUT': '86400', 02:06:02 INFO - 'USER': 'cltbld', 02:06:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:02 INFO - '_': '/tools/buildbot/bin/python'} 02:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:03 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:03 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 02:06:03 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 02:06:03 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 02:06:03 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 02:06:03 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 02:06:03 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 02:06:04 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06:05 INFO - Downloading docopt-0.6.1.tar.gz 02:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:05 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:05 INFO - Running setup.py install for blobuploader 02:06:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:05 INFO - Running setup.py install for requests 02:06:06 INFO - Running setup.py install for docopt 02:06:06 INFO - Successfully installed blobuploader requests docopt 02:06:06 INFO - Cleaning up... 02:06:06 INFO - Return code: 0 02:06:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:06 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 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:06:06 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 02:06:06 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 02:06:06 INFO - Using env: {'DISPLAY': ':0', 02:06:06 INFO - 'HOME': '/home/cltbld', 02:06:06 INFO - 'LANG': 'en_US.UTF-8', 02:06:06 INFO - 'LANGUAGE': 'en_US:en', 02:06:06 INFO - 'LOGNAME': 'cltbld', 02:06:06 INFO - 'MAIL': '/var/mail/cltbld', 02:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:06 INFO - 'MOZ_NO_REMOTE': '1', 02:06:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:06 INFO - 'NO_EM_RESTART': '1', 02:06:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:06 INFO - 'PWD': '/builds/slave/test', 02:06:06 INFO - 'SHELL': '/bin/bash', 02:06:06 INFO - 'SHLVL': '1', 02:06:06 INFO - 'TERM': 'linux', 02:06:06 INFO - 'TMOUT': '86400', 02:06:06 INFO - 'USER': 'cltbld', 02:06:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:06 INFO - '_': '/tools/buildbot/bin/python'} 02:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:06 INFO - Running setup.py (path:/tmp/pip-rt2StS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:06 INFO - Running setup.py (path:/tmp/pip-tUBAOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:06 INFO - Running setup.py (path:/tmp/pip-TtthmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:06 INFO - Running setup.py (path:/tmp/pip-sHpRck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:06 INFO - Running setup.py (path:/tmp/pip-qq1DgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:06 INFO - Running setup.py (path:/tmp/pip-TffeXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:06 INFO - Running setup.py (path:/tmp/pip-a4u0RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:07 INFO - Running setup.py (path:/tmp/pip-Ko7sOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:07 INFO - Running setup.py (path:/tmp/pip-gzYJHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:07 INFO - Running setup.py (path:/tmp/pip-_JUt2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:07 INFO - Running setup.py (path:/tmp/pip-f19aPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:07 INFO - Running setup.py (path:/tmp/pip-yB09au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:07 INFO - Running setup.py (path:/tmp/pip-nb4Lmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:07 INFO - Running setup.py (path:/tmp/pip-sycs_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:07 INFO - Running setup.py (path:/tmp/pip-131WrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:07 INFO - Running setup.py (path:/tmp/pip-iZY_ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:07 INFO - Running setup.py (path:/tmp/pip-T3SMk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:07 INFO - Running setup.py install for manifestparser 02:06:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:07 INFO - Running setup.py install for mozcrash 02:06:07 INFO - Running setup.py install for mozdebug 02:06:08 INFO - Running setup.py install for mozdevice 02:06:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Running setup.py install for mozfile 02:06:08 INFO - Running setup.py install for mozhttpd 02:06:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Running setup.py install for mozinfo 02:06:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Running setup.py install for mozInstall 02:06:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Running setup.py install for mozleak 02:06:08 INFO - Running setup.py install for mozlog 02:06:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Running setup.py install for moznetwork 02:06:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:08 INFO - Running setup.py install for mozprocess 02:06:08 INFO - Running setup.py install for mozprofile 02:06:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:09 INFO - Running setup.py install for mozrunner 02:06:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:09 INFO - Running setup.py install for mozscreenshot 02:06:09 INFO - Running setup.py install for moztest 02:06:09 INFO - Running setup.py install for mozversion 02:06:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:09 INFO - Cleaning up... 02:06:09 INFO - Return code: 0 02:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:09 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 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:06:09 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 02:06:09 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 02:06:09 INFO - Using env: {'DISPLAY': ':0', 02:06:09 INFO - 'HOME': '/home/cltbld', 02:06:09 INFO - 'LANG': 'en_US.UTF-8', 02:06:09 INFO - 'LANGUAGE': 'en_US:en', 02:06:09 INFO - 'LOGNAME': 'cltbld', 02:06:09 INFO - 'MAIL': '/var/mail/cltbld', 02:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:09 INFO - 'MOZ_NO_REMOTE': '1', 02:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:09 INFO - 'NO_EM_RESTART': '1', 02:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:09 INFO - 'PWD': '/builds/slave/test', 02:06:09 INFO - 'SHELL': '/bin/bash', 02:06:09 INFO - 'SHLVL': '1', 02:06:09 INFO - 'TERM': 'linux', 02:06:09 INFO - 'TMOUT': '86400', 02:06:09 INFO - 'USER': 'cltbld', 02:06:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:09 INFO - '_': '/tools/buildbot/bin/python'} 02:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:09 INFO - Running setup.py (path:/tmp/pip-Qf4ZbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:09 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)) 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:09 INFO - Running setup.py (path:/tmp/pip-_GuLnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:09 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)) 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:09 INFO - Running setup.py (path:/tmp/pip-BHogD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:09 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)) 02:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:09 INFO - Running setup.py (path:/tmp/pip-5dOGrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:10 INFO - Running setup.py (path:/tmp/pip-h0kIhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:10 INFO - Running setup.py (path:/tmp/pip-tnFeqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:10 INFO - Running setup.py (path:/tmp/pip-yvGvRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:10 INFO - Running setup.py (path:/tmp/pip-MPM_k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:10 INFO - Running setup.py (path:/tmp/pip-NvUxtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:10 INFO - Running setup.py (path:/tmp/pip-mjncZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:10 INFO - Running setup.py (path:/tmp/pip-MYZ4f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:10 INFO - Running setup.py (path:/tmp/pip-_yfFzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:10 INFO - Running setup.py (path:/tmp/pip-QpzvyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:10 INFO - Running setup.py (path:/tmp/pip-tiRSEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:10 INFO - Running setup.py (path:/tmp/pip-0Z_TRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:10 INFO - Running setup.py (path:/tmp/pip-Ex4lmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:10 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)) 02:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:10 INFO - Running setup.py (path:/tmp/pip-6QTMmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:10 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)) 02:06:10 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)) 02:06:10 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)) 02:06:10 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)) 02:06:10 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)) 02:06:10 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)) 02:06:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06:12 INFO - Downloading blessings-1.6.tar.gz 02:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:12 INFO - Installing collected packages: blessings 02:06:12 INFO - Running setup.py install for blessings 02:06:13 INFO - Successfully installed blessings 02:06:13 INFO - Cleaning up... 02:06:13 INFO - Return code: 0 02:06:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:13 INFO - Reading from file tmpfile_stdout 02:06:13 INFO - Current package versions: 02:06:13 INFO - argparse == 1.2.1 02:06:13 INFO - blessings == 1.6 02:06:13 INFO - blobuploader == 1.2.4 02:06:13 INFO - docopt == 0.6.1 02:06:13 INFO - manifestparser == 1.1 02:06:13 INFO - mozInstall == 1.12 02:06:13 INFO - mozcrash == 0.17 02:06:13 INFO - mozdebug == 0.1 02:06:13 INFO - mozdevice == 0.48 02:06:13 INFO - mozfile == 1.2 02:06:13 INFO - mozhttpd == 0.7 02:06:13 INFO - mozinfo == 0.9 02:06:13 INFO - mozleak == 0.1 02:06:13 INFO - mozlog == 3.1 02:06:13 INFO - moznetwork == 0.27 02:06:13 INFO - mozprocess == 0.22 02:06:13 INFO - mozprofile == 0.28 02:06:13 INFO - mozrunner == 6.11 02:06:13 INFO - mozscreenshot == 0.1 02:06:13 INFO - mozsystemmonitor == 0.0 02:06:13 INFO - moztest == 0.7 02:06:13 INFO - mozversion == 1.4 02:06:13 INFO - psutil == 3.1.1 02:06:13 INFO - requests == 1.2.3 02:06:13 INFO - wsgiref == 0.1.2 02:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:13 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')]} 02:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:13 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')]} 02:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:13 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 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:06:13 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 02:06:13 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 02:06:13 INFO - Using env: {'DISPLAY': ':0', 02:06:13 INFO - 'HOME': '/home/cltbld', 02:06:13 INFO - 'LANG': 'en_US.UTF-8', 02:06:13 INFO - 'LANGUAGE': 'en_US:en', 02:06:13 INFO - 'LOGNAME': 'cltbld', 02:06:13 INFO - 'MAIL': '/var/mail/cltbld', 02:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:13 INFO - 'MOZ_NO_REMOTE': '1', 02:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:13 INFO - 'NO_EM_RESTART': '1', 02:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:13 INFO - 'PWD': '/builds/slave/test', 02:06:13 INFO - 'SHELL': '/bin/bash', 02:06:13 INFO - 'SHLVL': '1', 02:06:13 INFO - 'TERM': 'linux', 02:06:13 INFO - 'TMOUT': '86400', 02:06:13 INFO - 'USER': 'cltbld', 02:06:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:13 INFO - '_': '/tools/buildbot/bin/python'} 02:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 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)) 02:06:13 INFO - Cleaning up... 02:06:13 INFO - Return code: 0 02:06:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:13 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')]} 02:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:13 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')]} 02:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:13 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 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:06:13 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 02:06:13 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 02:06:13 INFO - Using env: {'DISPLAY': ':0', 02:06:13 INFO - 'HOME': '/home/cltbld', 02:06:13 INFO - 'LANG': 'en_US.UTF-8', 02:06:13 INFO - 'LANGUAGE': 'en_US:en', 02:06:13 INFO - 'LOGNAME': 'cltbld', 02:06:13 INFO - 'MAIL': '/var/mail/cltbld', 02:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:13 INFO - 'MOZ_NO_REMOTE': '1', 02:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:13 INFO - 'NO_EM_RESTART': '1', 02:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:13 INFO - 'PWD': '/builds/slave/test', 02:06:13 INFO - 'SHELL': '/bin/bash', 02:06:13 INFO - 'SHLVL': '1', 02:06:13 INFO - 'TERM': 'linux', 02:06:13 INFO - 'TMOUT': '86400', 02:06:13 INFO - 'USER': 'cltbld', 02:06:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:13 INFO - '_': '/tools/buildbot/bin/python'} 02:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:13 INFO - Downloading/unpacking jsonschema 02:06:13 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 02:06:13 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 02:06:13 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 02:06:13 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 02:06:13 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 02:06:13 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 02:06:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:15 INFO - Downloading/unpacking functools32 (from jsonschema) 02:06:15 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 02:06:15 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 02:06:15 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 02:06:15 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 02:06:15 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 02:06:15 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 02:06:15 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:15 INFO - warning: no files found matching '*.txt' 02:06:15 INFO - no previously-included directories found matching 'build' 02:06:15 INFO - no previously-included directories found matching 'dist' 02:06:15 INFO - no previously-included directories found matching '.git*' 02:06:15 INFO - Installing collected packages: jsonschema, functools32 02:06:16 INFO - Running setup.py install for functools32 02:06:16 INFO - warning: no files found matching '*.txt' 02:06:16 INFO - no previously-included directories found matching 'build' 02:06:16 INFO - no previously-included directories found matching 'dist' 02:06:16 INFO - no previously-included directories found matching '.git*' 02:06:16 INFO - Successfully installed jsonschema functools32 02:06:16 INFO - Cleaning up... 02:06:16 INFO - Return code: 0 02:06:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ac39ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12175a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', '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 02:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:06:16 INFO - Using env: {'DISPLAY': ':0', 02:06:16 INFO - 'HOME': '/home/cltbld', 02:06:16 INFO - 'LANG': 'en_US.UTF-8', 02:06:16 INFO - 'LANGUAGE': 'en_US:en', 02:06:16 INFO - 'LOGNAME': 'cltbld', 02:06:16 INFO - 'MAIL': '/var/mail/cltbld', 02:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:16 INFO - 'MOZ_NO_REMOTE': '1', 02:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:16 INFO - 'NO_EM_RESTART': '1', 02:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:16 INFO - 'PWD': '/builds/slave/test', 02:06:16 INFO - 'SHELL': '/bin/bash', 02:06:16 INFO - 'SHLVL': '1', 02:06:16 INFO - 'TERM': 'linux', 02:06:16 INFO - 'TMOUT': '86400', 02:06:16 INFO - 'USER': 'cltbld', 02:06:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:16 INFO - '_': '/tools/buildbot/bin/python'} 02:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:16 INFO - Downloading/unpacking flake8 02:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:06:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:06:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:19 INFO - no previously-included directories found matching 'docs/_build' 02:06:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:06:19 INFO - Running setup.py install for pep8 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:19 INFO - no previously-included directories found matching 'docs/_build' 02:06:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:06:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:06:19 INFO - Cleaning up... 02:06:19 INFO - Return code: 0 02:06:19 INFO - Running post-action listener: _resource_record_post_action 02:06:19 INFO - Running post-action listener: _start_resource_monitoring 02:06:19 INFO - Starting resource monitoring. 02:06:19 INFO - ##### 02:06:19 INFO - ##### Running install step. 02:06:19 INFO - ##### 02:06:19 INFO - Running pre-action listener: _resource_record_pre_action 02:06:19 INFO - Running main action method: install 02:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:19 INFO - Reading from file tmpfile_stdout 02:06:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:19 INFO - Reading from file tmpfile_stdout 02:06:19 INFO - Output received: 02:06:19 INFO - Usage: mozinstall [options] installer 02:06:19 INFO - Options: 02:06:19 INFO - -h, --help show this help message and exit 02:06:19 INFO - -d DEST, --destination=DEST 02:06:19 INFO - Directory to install application into. [default: 02:06:19 INFO - "/builds/slave/test"] 02:06:19 INFO - --app=APP Application being installed. [default: firefox] 02:06:19 INFO - mkdir: /builds/slave/test/build/application 02:06:19 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'] 02:06:19 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 02:06:32 INFO - Reading from file tmpfile_stdout 02:06:32 INFO - Output received: 02:06:32 INFO - /builds/slave/test/build/application/firefox/firefox 02:06:32 INFO - Running post-action listener: _resource_record_post_action 02:06:32 INFO - ##### 02:06:32 INFO - ##### Running run-tests step. 02:06:32 INFO - ##### 02:06:32 INFO - Running pre-action listener: _resource_record_pre_action 02:06:32 INFO - Running main action method: run_tests 02:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:32 INFO - Python 2.7.3 02:06:32 INFO - Return code: 0 02:06:32 INFO - grabbing minidump binary from tooltool 02:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:32 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 0x12a6410>, '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 0x12a7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12a77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:32 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 02:06:32 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 02:06:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:33 INFO - Return code: 0 02:06:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:06:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:06:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:06:33 INFO - Return code: 0 02:06:33 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/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 02:06:33 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/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 02:06:33 INFO - Using env: {'DISPLAY': ':0', 02:06:33 INFO - 'HOME': '/home/cltbld', 02:06:33 INFO - 'LANG': 'en_US.UTF-8', 02:06:33 INFO - 'LANGUAGE': 'en_US:en', 02:06:33 INFO - 'LOGNAME': 'cltbld', 02:06:33 INFO - 'MAIL': '/var/mail/cltbld', 02:06:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:33 INFO - 'MOZ_NO_REMOTE': '1', 02:06:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:33 INFO - 'NO_EM_RESTART': '1', 02:06:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:33 INFO - 'PWD': '/builds/slave/test', 02:06:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:33 INFO - 'SHELL': '/bin/bash', 02:06:33 INFO - 'SHLVL': '1', 02:06:33 INFO - 'TERM': 'linux', 02:06:33 INFO - 'TMOUT': '86400', 02:06:33 INFO - 'USER': 'cltbld', 02:06:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220', 02:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:33 INFO - '_': '/tools/buildbot/bin/python'} 02:06:33 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/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 02:06:34 INFO - mozversion application_buildid: 20160606194329 02:06:34 INFO - mozversion application_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:06:34 INFO - mozversion application_display_name: Firefox 02:06:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:34 INFO - mozversion application_name: Firefox 02:06:34 INFO - mozversion application_remotingname: firefox 02:06:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:06:34 INFO - mozversion application_vendor: Mozilla 02:06:34 INFO - mozversion application_version: 48.0 02:06:34 INFO - mozversion platform_buildid: 20160606194329 02:06:34 INFO - mozversion platform_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:06:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:06:34 INFO - mozversion platform_version: 48.0 02:06:34 INFO - using testdate: 1465290394 02:06:34 INFO - actual date: 1465290394 02:06:34 INFO - starting webserver on 'localhost:39761' 02:06:34 INFO - SUITE-START | Running 2 tests 02:06:34 INFO - TEST-START | dromaeo_css 02:06:34 INFO - operating with platform_type : linux_ 02:06:34 INFO - Initialising browser for dromaeo_css test... 02:06:34 INFO - TEST-INFO | started process 3270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE56nO2/profile http://localhost:39761/getInfo.html) 02:06:39 INFO - PROCESS | 3270 | 02:06:39 INFO - PROCESS | 3270 | (process:3352): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:06:40 INFO - PROCESS | 3270 | __metrics Screen width/height:1600/1200 02:06:40 INFO - PROCESS | 3270 | colorDepth:24 02:06:40 INFO - PROCESS | 3270 | Browser inner width/height: 1024/697 02:06:40 INFO - PROCESS | 3270 | __metrics 02:06:40 ERROR - PROCESS | 3270 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:06:41 INFO - TEST-INFO | 3270: exit 0 02:06:41 INFO - Browser initialized. 02:06:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:41 INFO - TEST-INFO | started process 3403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE56nO2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:43 INFO - PROCESS | 3403 | 02:06:43 INFO - PROCESS | 3403 | (process:3470): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:06:53 INFO - PROCESS | 3403 | RSS: Main: 151547904 02:06:53 INFO - PROCESS | 3403 | 02:07:43 INFO - PROCESS | 3403 | 1465290463168 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] 02:09:50 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:39761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39761/tests/dromaeo/cssquery-ext.html) 02:09:51 INFO - PROCESS | 3403 | RSS: Main: 155734016 02:09:51 INFO - PROCESS | 3403 | 02:12:53 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:39761/tests/dromaeo/cssquery-ext.html (next: http://localhost:39761/tests/dromaeo/cssquery-jquery.html) 02:12:53 INFO - PROCESS | 3403 | RSS: Main: 152772608 02:12:53 INFO - PROCESS | 3403 | 02:15:55 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:39761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39761/tests/dromaeo/cssquery-mootools.html) 02:15:56 INFO - PROCESS | 3403 | RSS: Main: 152444928 02:15:56 INFO - PROCESS | 3403 | 02:18:57 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:39761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39761/tests/dromaeo/cssquery-prototype.html) 02:18:58 INFO - PROCESS | 3403 | RSS: Main: 154288128 02:18:58 INFO - PROCESS | 3403 | 02:22:00 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:39761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39761/tests/dromaeo/cssquery-yui.html) 02:22:01 INFO - PROCESS | 3403 | RSS: Main: 152834048 02:22:01 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | Cycle 1(1): loaded http://localhost:39761/tests/dromaeo/cssquery-yui.html (next: http://localhost:39761/tests/dromaeo/cssquery-dojo.html) 02:25:03 INFO - PROCESS | 3403 | RSS: Main: 156274688 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | __start_tp_report 02:25:03 INFO - PROCESS | 3403 | _x_x_mozilla_page_load 02:25:03 INFO - PROCESS | 3403 | _x_x_mozilla_page_load_details 02:25:03 INFO - PROCESS | 3403 | |i|pagename|runs| 02:25:03 INFO - PROCESS | 3403 | |0;dojo.html;3323.3519463704574;3368.831558422078;3371.022403502984;3390.7456940729435;3406.778559393639;5603.915941260884;5616.887662246752;5627.549796016319;5645.407232240617;5663.490285874275;5624.465675760806;5643;5650.5479561635075;5652.152177173416;5654.773809047643;5095.439501654824;5119.59043276537;5134.666246693953;5149.0731668299695;5220.791168353261;4872.3422337984275;4939.728314942695;5084.923726144111;5108.157154069574;5155.046316431453;5063.265826455162;5079.187330027178;5086.287919691246;5087.56755675768;5152.124138896378;5119.513646203604;5123.795048198068;5126.487351264881;5134.435212126663;5147.974260128713;4907.043126590316;4946.233333833262;4988.65079444439;5042.949570504321;5062.721550314731;5327.680339179623;5354.973225133888;5356.7321633918145;5371.382291036542;5380.677159370451;5820.82537523875;5828.504577110951;5829.271341082364;5834.533237341003;5853.473187413153;5885.529157667419;5917.6449413034925;5933.495652869468;5974.283086029661;6002.699865006733;5662.688552129631;5690.857728556778;5693.487586117228;5695.487406133468;5700.9429905701245;6047.123167140828;6184.6598437086395;6226.719797609027;6247.437730604267;6251.468625166821;5882.529397648178;5894.233749612523;5911.083782013795;5917.437843404869;5917.55618328627;5941.168236446901;5960.344362120163;5962.195103661037;5964.85087872798;5971.880562388728;5667.376588575254;5750.884982300414;5923.4668879800165;5934.198883150806;5962.493188078975;5930.822075337746;5971.373005834324;5977;5978.970105149447;6014.48876845473;4489.0572979674635;4545.045540436479;4551.817927282872;4573.794179261941;4582.945922437858;3977.2642061218767;4001.079751657135;4116.5060192777055;4118.341065429577;4135.31767258405;5719.628224165499;5815.592908496449;5822.854428639318;5837.09525023622;5893.3222679391565;5971.611845230046;5982.7008649568215;6016.2479690038745;6022.277326720821;6050.6974651267265;5542.778288868481;5724.284464441945;5788.739506722208;5815;5834.3290521589715;4951.10880041596;5016.197408414636;5029.1953287473825;5054.974725126351;5058.988202359543;6250.874982500324;6294.087357333253;6302.810915672537;6305.464035556937;6317.778877739257;5825.563082768725;5893.823185304276;5951.3751056139345;6021.759129634941;6064.666443345658;5969.492593129633;5992.98119319708;6201.10084037821;6231.376862313732;6343.048542718445;5789.710514474175;5799.217105690846;5799.913001305068;5804.9709751452665;5854.268216472941;5806.129080637938;5852.707364631837;5860.941390586039;5898.026825573732;5898.852528686817;5785.218995435563;5842.620229685057;5877.617954832922;5907.3797251288;5945.435183657719;5687.658740475585;5689.687067211343;5692.51613612831;5694.572907032072;5698.088305871041;5594.300712410949;5617.157426386075;5618.747156377891;5638.9436105638415;5658.688772117573;5945.881082378415;5947.137665038459;5983.670898100646;5995.130706047511;5998.670073146019;5795.507381872588;5807.767689292381;5824.679642619697;5824.854378640398;5834.883302334015 02:25:03 INFO - PROCESS | 3403 | |1;ext.html;679.4496457869125;686.9313068693132;707.7770502291775;746.1307576673178;791.5290402210683;39480;40668.38997415038;40730.18539629206;40775.592244077554;40792.18415631686;41168.38247426291;41817;41923;41968.370474442905;42151;8907.242884354837;9122.22461090808;9155.359124861263;9161.267098632094;9179.127982841619;8957.507337096456;9023.864642030374;9039;9042.819143617124;9072.00207977122;9044.457332560067;9097;9119.088091190893;9138.040505746867;9176.082391760838;9040.954795226015;9044.3668943174;9100.226480749145;9118.316126290489;9135.451872887648;8992.685256016073;9065.41074830134;9116.270698344117;9120.407173533766;9142.58858351369;42039.57960420418;42382.78808605968;42433;42528.57471425277;44469;3847.5960024197334;3877.689784817208;3900.278448487039;4020.356742921148;4180.456540649727;32194.678053219635;33866;33891.83054084738;34040.31919361624;34506.137346566284;4264.189803937273;4289.206496798102;4312.159128969852;4338.197433474786;4372.497162826252;336820;341528;342967;344306;346090;38716;39210.803945980086;64077.35922640714;64351;64404.35595643984;40309.39535906964;40326.59673403287;40372.79813600913;40398.39402408966;40493.39259911104;16050.518484445485;16209.67580648404;16233.431829886133;16252.268647910872;16313.83686163147;13529.120607160503;13549.932250338883;13556;13556.661083472993;13612.795808062887;9354.859677104849;9365.578548965314;9410.294227932933;9431.669891553762;9453.66912158085;3644.817759112034;3711.684506816897;3715.3869611514338;3729.5151630287887;3736.5889752127246;1189.8334233207358;1213.1932265043824;1229.244014930829;1254.6737848159362;1261.8864302212844;30429.69570304313;33688.663113369046;34351.82824085864;34400.311993759984;34490.82754586211;1174.2602160638744;1185.7154282972024;1233.1860971758776;1301.7266374061553;1311.731095125497;17441;17582.73625895587;17711.822881771273;17763;17775.200115994812;499568;506374;509657;518316;523480;56051.47768350434;57030;57129;57146.42853571494;57278.7136064317;1485.7474229381248;1508.8038554987781;1518.5216656753307;1545.7526795712631;1613.4191690991233;31564;31740.841295793372;33137.50293745644;35188.29623407466;35615.643843561236;54594.72702636461;54975.17537236865;55072.17391739207;55278.44721552894;55484.445155547925;423419;424004;424320;424860;426296;30336.241593960327;30574.235644109074;30854.691453085183;31131;31281.8435907819;50974.74512627413;51410.48589514057;52025;52796;53213.20180197222;42935.62206015471;43328.56671433371;43721.34417983669;43907.560924390345;44858.77570612126;42470.36294455647;42796;43894.780526098446;44267.33598995953;44761.328580071975;44019;44383.334249986925;44436.555634444536;44506.55493445154;45617.54382456133;37867;38047;38706.2576784367;38764.61235387723;38802.80598596989;29951.850240748656;30342.84828575843;30408.087757367313;30523.2369190772;30560.388792224476 02:25:03 INFO - PROCESS | 3403 | |2;jquery.html;405.0683428115334;412.4617374326503;413.27057743083463;413.45630495897893;420.98947526311855;18675.62648747026;19309.613807723836;19373.612527749454;19508.21967121317;20821.167153313887;20188.394348169542;20575.27986520472;20600.89699551504;20772.06525706343;20777.792222077813;5459.727013649322;5563.221149039117;5636.210930469727;5771.884562308751;5889.646621202742;5735.168400581913;5855.151003104547;5879.559033072515;5889.02831032879;5889.911651325234;5499.7250137493165;5758.280214973129;5799.768009279624;5831.241938548004;5835.095560188178;5645.181448689958;5650.0959846424375;5704.172894930232;5740.684262365589;5761.82714518563;5481.095619222823;5632.915506267409;5637.746301416446;5657.066584013633;5663.292088488939;13835.446582136703;14053.508127215498;14055.78916316256;14176.220307883063;14181;2514.6353778701987;2574.4464940037983;2578.742125787425;2693.8114331996767;3059.189314831571;10010.649627263083;10129.240306976932;10133.645322413753;10380.636677716318;10425.843612345821;2046.3963130876277;2056.043939568108;2072.9792702072937;2093.7382827146607;2114.925977590792;79227.6038619809;82675.5866220671;82707.5864620679;83032.58483707604;83285.58357208176;10030.44832534203;10442.791144177074;11059.447027648584;11174.66476005721;11193;14830.33263503145;15153.848461515465;15323.770143447857;15411.845881541265;15485.148316842682;8120;8226.547539885363;8354.749357519284;8372.288355489729;8612.913870861212;7724.6523906424345;7759.7672069838;7770.41721870862;7803.375729941591;7804.531728096333;4691;4738.857834264978;4749.453812811502;4768.928466073012;4884.877878053006;1964.7818352621466;2017.8083082107175;2048.2114385961513;2085.738128432307;2088.7806780288156;1014.7158795537262;1073.4954571351452;1136.9545218191345;1137.9203455758018;1155.399192419937;16539;18740.906295468434;19322.32371866978;19639.410817675493;19831.702524462144;1081.5944020992129;1137.5222406589253;1142.2404101272728;1167.1538134852333;1176.9352685602373;10833.891661083446;10969.23215374932;10999;11054.834177487344;11118.110551155889;517058;524153;525289;532706;534442;52576.73711631417;59990;88462;89406;90633;1093.4805967165692;1107.3134656512852;1110.3116068037868;1116.6036057199576;1123.5955056179769;17067.06131162798;17188.484345469657;17337.133143343035;17338.653226935643;17428.128593570018;37141.81429092837;37142.8142859284;37898.810505947295;38805.2238955225;38837.61162388453;54421;56938.715306423204;57039.429605703415;57657.423425765206;57765.422345776;8417.116202798863;8484.23477086809;8671.34964877624;8739.781505462413;8792.252658523841;9622.326437149331;12286.938565307117;13433;13516.459341626225;14123.152610843383;12214.389280536116;12730.299833509245;13004.609861704164;13045.217286962812;13089.280089594782;12513.311767852856;12544.059195560187;12595.05537084704;12747.362631868184;12751.872481275068;12714.87285127137;13194.80207796903;13259.403326850123;13327.66680832987;13393.330333483482;8878.595636570673;8903.688370906988;8973.910260897308;9041.502717350346;9070.455772653662;9027.774305642411;11318.660440186808;11882.82175767347;11909.344986025852;12017.879821201675 02:25:03 INFO - PROCESS | 3403 | |3;mootools.html;1592.0845513829547;1608.332541995072;1820.1263393571085;1915.5689969756797;1925.5571218619716;8333.083360830304;8441.493510389366;8491.0659827419;8574.442661227016;8581.52801595912;8721.12788721129;8745.256653184488;8770.824583508342;8825.293976481882;8885.644574217024;2357.127862690807;2379.9048038078454;2386.880655967195;2391.3782416571644;2398.136670798511;2407.2898494943947;2415.384077060347;2474.75252474752;2482.553140434721;2484.5776218042884;2407.3620490570015;2417.1177520205174;2437.2322718343667;2440.792532634728;2440.8779561021965;2367.881605919697;2377.857328560292;2414.311921102486;2424.7938925191293;2427.4295540548046;2419.0444774314046;2474.072222916406;2477.677901872763;2482.6648402465617;2486.950260994788;8768.561571921442;8781.56092195394;8830.116988301183;8839.07189745074;8840.513771742551;5204.959008198375;5280.471952804727;5303.098473259555;5316.946830531722;5330.92003619946;3522.4716292556063;3551.094470909927;3584.5698516177963;3622;3670.4861319415304;1154.2612727854096;1160.5067846165346;1175.935323557204;1191.6603767926185;1202.1705023533734;12027.699307517294;12049.939750301193;12144.271343719316;12151.756964860653;12170.57402990891;4436.3567282743825;4539.228331183706;4571.291449825282;4600.5169457207185;4616.561426664462;9796.314258002014;9866.654667086617;9866.851997220047;9868.80262394748;9880;5239.73801309933;5241.68549887008;5243.056249875059;5261.657992230493;5265.973670131625;4819.277108433693;4930.457649658535;4945.505449455098;4957.380327459067;4975.353204083518;3800.3539398302355;3829.6744776693736;3883.728139030241;3895.0651843557343;3944.901377465529;1129.5989923577176;1135.9261647992853;1145.9083273338113;1174.1135442740676;1183.1776915044134;923.0630909626734;926.8424367857481;1033.2921948465325;1075.870895492546;1089.2375337263788;5984.072468767348;6067.089936509471;6169.290531588925;6223.471004964538;6272.560920735505;466.55677106748726;468.63914785614884;471.617989428564;472.7258190249647;495.8165478772877;4229.2598795210715;4267.4025636410925;4272.636825869836;4305.84929527465;4321.69748117635;10342.069213770797;10574.89425105739;10588.947055264674;10663.680089597325;10709.839352409721;10386.948065259776;10503.2122590806;10531.57873685044;10547.103496202908;10572.629957951434;7841.137474877759;8034.995625546923;8105.311048560939;8134.430589858653;8266.04940431846;5631.662100273997;5641.26663533738;5675.68783716883;5685.658860468385;5743.511801496919;9265.305102117234;9350.438973661601;9414.246860251027;9448.96061433228;9481.66814161501;9231.58457869384;9393.85909211376;9410.717678469657;9431.952840235756;9507.096825801538;6794.3545363190415;7451.552906825608;7649.158592554926;7688.692452301845;7778.649960751893;8298.792530186794;8299.958500207702;8312.792180195544;8326.417150799385;8351.832963340821;7058.11773528309;7469.327760501581;7517.248275172439;7523.774286771406;7566;7407.66665500043;7418.812989921803;7421;7536.472446928662;7569.848603028019;6963.79108626742;6994.685239164148;7098.787036388917;7125.287471252833;7130.750423735144;5189.351331083614;5260.552853007537;5264.763085661231;5364.544013758718;5378.784848606168;5179.81870634526;5186.766595503136;5209.192575150858;5238.895222095613;5245.396779370421 02:25:03 INFO - PROCESS | 3403 | |4;prototype.html;336.6162574664881;337.5038693121112;340.04447502517917;343.9019879334389;348.48946293679757;6542.084108224853;6647.335266473357;6658.533902626812;6659.300773418794;6710.899336509956;6558.508111891615;6561.475081993441;6562.573432726869;6568.211814582245;6600.636964966925;4712.222483290261;4749.216379297429;4755.45312289086;4768.23708206687;4773.140834649762;4737.976310118462;4775.689580177294;4787.8324258650955;4842.418909730837;4856.97571512142;4757.857264282077;4773.522647735216;4786.880327991793;4802.783874725628;4804.37543119394;4801.855944321658;4810.518948105197;4816.8554943351755;4828.227483602642;4832.855014349575;4120.25835349637;4124.876253712393;4125.814338354751;4132.91734165318;4139.503259608866;6077.453029227391;6310.9684451577905;6319.178506794087;6319.494440444753;6328.3988021138375;5616.129499927518;5642.605017648766;5668.149777533362;5675.9432405675825;5687.744051517691;6873.518853680244;6901.896471552931;6918.515703900729;6923.723051077951;6940.444764418834;4625.444946606429;4633.328167415706;4645.210314246586;4655.86032419028;4668.883277918046;7207.423406127497;7267.927320726778;7280.890786638205;7282.05333306672;7287.125544934589;4678.3216433616935;4753;4758.928616070762;4766.213574760126;4779.808807647655;4781.569658730731;4813.470518242991;4819.662623616313;4826.782794774173;4837.32277481153;5647;5648.15277708347;5657.20799088128;5657.20799088128;5666.943330566724;6961.860762784716;6983.790486285419;7023.754168604074;7034.92965070353;7038.612876291853;1680.932762689503;1696.6691495158573;1698.8471037606676;1704.3608646757466;1707.709689352813;1053.2364036073784;1074.3929679730927;1083.3012706804068;1086.375334182848;1105.90599799018;6773.322667733188;6806.285340039323;6807.4894382921475;6810.693518791666;6816.965915170393;7116.786496405116;7136.750213742494;7157.534760240567;7163.06880105583;7194.784156475314;6648.66756662165;6820.965895170492;6869.313068693091;6894.689738961759;6902.585844849325;3884.3396622574232;3901.395283731026;3904.2191561687778;3920.843166273374;3932.1545867638597;7578.12851522071;7636.3890888728765;7638.274363935418;7641.69433222676;7647.082350118021;7311.341979221789;7438.925610743823;7443.144038435541;7443.8883416748795;7453.366463850633;7588.848223035508;7591.544507329468;7591.962040189764;7610.6194690265265;7628.80927976805;7253.419726421768;7266.273372662903;7272.05463289769;7280.089988751406;7290.161631412243;7108.324709152622;7141.321574450419;7149.499535032706;7159.463040271896;7177.282271772781;7411.740589079356;7599.392048635986;7617.809554761176;7622.69509219625;7626.6186690664135;4698.835540756194;4746.311784791255;4752.287156926489;4752.5485078917445;4771.785269662804;7235.095613048369;7245.311695388929;7247.9637601811655;7248.238934911758;7259.52813067149;7001.124859392576;7007.509474336747;7016.333448322402;7016.894746578908;7043.823904402431;6822.761203357859;6947.756828510978;6995.230524642184;6996.860062798613;7030.367266945999;6844.623545704835;6879.724811007503;6882.139732533434;6885.070515480346;6894.172699276119;7044.049053377728;7050.189228238613;7050.8237294066;7051;7056.894146587908;6853.760118395832;6855.348741869514;6860.3139686031;6860.862782744417;6871.3128687132885 02:25:03 INFO - PROCESS | 3403 | |5;yui.html;950.5817440326256;952.8427809411445;961.95190240488;971.4754032822276;981.730024243333;14772.852271477283;15031.248437578131;15031.774523382159;15044;15053.92473037636;14428.639284017905;14541.34563944625;14575.854241457582;14584.124952502858;14595;763.4541302968377;882.4440602420498;892.7589550821274;893.5621545442751;901.2069378946518;864.9264812490945;866.1425189062845;867.652938824469;868.535333596526;868.8696695495663;958.1041725986225;959.6737109382808;959.755262408085;960.1454705312243;961.9086186812242;948.9905100949005;949.4920217683506;953.9141477267044;954.5322791831987;963.0177219236409;696.7004188199072;702.7891632510226;708.2244941788733;708.518207618819;709.6274455910689;14615.70768584633;14663.41346346145;14689.77965330521;14691.77962330566;14715.484958026418;14368.856311436857;14477.276136193253;14559.12645241289;14577.854221457756;14591.635209119751;12104.81842772359;12431.689207769788;12620.936895315464;12742;12976.545820896317;3974.642282194616;3992.640662340374;4021.3565829467143;4022;4043.0296728785174;56202;56612;57259.42740572582;57392;57554.71222643902;11258.43707814606;11598.76802463946;11612.245204061708;11755.118366122575;11914.821277680841;21861;22001.449963750714;22001.449963750714;22007.889960550096;22582.322530324116;8784.516851573226;8848.557572121368;8952.104789521127;8969.416987895765;9158.771030724285;4760.7619619018915;4859.514048595112;4895.485973972753;4915.729634870117;4932.334134891744;3670.1925576373155;3751.324761542894;3754.8310326035394;3755.7370984030854;3756.868509602151;642.6369101457755;646.8835609590319;654.5974225851068;666.4068978609042;670.045185610503;781.004219619989;798.4969469234461;813.8901248331399;827.6234313387515;835.6699103854065;9195.862062069074;9228.446293222294;9380.343375963754;9580.66467673628;9591.232701383873;726.2555880222814;726.440640706653;738.0516036892567;752.1162633905249;763.0804880119442;4592.402987611589;4598.816047358068;4711.575958163782;4827.468978412372;4865;61634.38365616376;63207.367926321065;63375;68382.65808671025;68428.65785671139;51499.227511587356;51807;51821.48178518166;52813;52929.47070529246;49879;51102.48897510977;51672.741636291576;52384.999999999236;52507;9439.15973047948;9502.61989520439;9579.329446938926;9634.421934683662;10256.641017564349;36162;37260.81369593243;38683.41974870323;39137.41293880537;39780.60219397769;46287.768561156976;46565;49772.75113624553;50603.2409513865;51853;12592.811107833573;12798.296093714935;12984.15602985803;13055.608331750063;13146.802797957847;13841.584752457442;14016.844962478224;14095.577132686036;14525.27373631293;14560.85439145595;13081.477866366356;13224.338783060615;13303;13385.66535836612;13593.116447430886;12862.742745145231;13618.250996195304;13626.727465450835;13884;14421.351039203471;13266.469341226242;13312;13660.590182294547;13890.930545347208;13893.791593125909;10716.35701857891;10753.731156721145;10980.396078215455;11025.17311201647;11064.28082174656;10816.837747433952;10910.836337455103;11038.889611103787;11075.667729968114;11103.611373601885 02:25:03 INFO - PROCESS | 3403 | __end_tp_report 02:25:03 INFO - PROCESS | 3403 | __start_cc_report 02:25:03 INFO - PROCESS | 3403 | _x_x_mozilla_cycle_collect,327 02:25:03 INFO - PROCESS | 3403 | __end_cc_report 02:25:03 INFO - PROCESS | 3403 | __startTimestamp1465291503663__endTimestamp 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | ------- Summary: start ------- 02:25:03 INFO - PROCESS | 3403 | Number of tests: 6 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | [#0] dojo.html Cycles:165 Average:5545.30 Median:5789.71 stddev:621.34 (10.7%) stddev-sans-first:598.30 02:25:03 INFO - PROCESS | 3403 | Values: 3323.4 3368.8 3371.0 3390.7 3406.8 5603.9 5616.9 5627.5 5645.4 5663.5 5624.5 5643.0 5650.5 5652.2 5654.8 5095.4 5119.6 5134.7 5149.1 5220.8 4872.3 4939.7 5084.9 5108.2 5155.0 5063.3 5079.2 5086.3 5087.6 5152.1 5119.5 5123.8 5126.5 5134.4 5148.0 4907.0 4946.2 4988.7 5042.9 5062.7 5327.7 5355.0 5356.7 5371.4 5380.7 5820.8 5828.5 5829.3 5834.5 5853.5 5885.5 5917.6 5933.5 5974.3 6002.7 5662.7 5690.9 5693.5 5695.5 5700.9 6047.1 6184.7 6226.7 6247.4 6251.5 5882.5 5894.2 5911.1 5917.4 5917.6 5941.2 5960.3 5962.2 5964.9 5971.9 5667.4 5750.9 5923.5 5934.2 5962.5 5930.8 5971.4 5977.0 5979.0 6014.5 4489.1 4545.0 4551.8 4573.8 4582.9 3977.3 4001.1 4116.5 4118.3 4135.3 5719.6 5815.6 5822.9 5837.1 5893.3 5971.6 5982.7 6016.2 6022.3 6050.7 5542.8 5724.3 5788.7 5815.0 5834.3 4951.1 5016.2 5029.2 5055.0 5059.0 6250.9 6294.1 6302.8 6305.5 6317.8 5825.6 5893.8 5951.4 6021.8 6064.7 5969.5 5993.0 6201.1 6231.4 6343.0 5789.7 5799.2 5799.9 5805.0 5854.3 5806.1 5852.7 5860.9 5898.0 5898.9 5785.2 5842.6 5877.6 5907.4 5945.4 5687.7 5689.7 5692.5 5694.6 5698.1 5594.3 5617.2 5618.7 5638.9 5658.7 5945.9 5947.1 5983.7 5995.1 5998.7 5795.5 5807.8 5824.7 5824.9 5834.9 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | [#1] ext.html Cycles:180 Average:58702.56 Median:42003.98 stddev:114320.93 (272.2%) stddev-sans-first:114558.63 02:25:03 INFO - PROCESS | 3403 | Values: 679.4 686.9 707.8 746.1 791.5 39480.0 40668.4 40730.2 40775.6 40792.2 41168.4 41817.0 41923.0 41968.4 42151.0 8907.2 9122.2 9155.4 9161.3 9179.1 8957.5 9023.9 9039.0 9042.8 9072.0 9044.5 9097.0 9119.1 9138.0 9176.1 9041.0 9044.4 9100.2 9118.3 9135.5 8992.7 9065.4 9116.3 9120.4 9142.6 42039.6 42382.8 42433.0 42528.6 44469.0 3847.6 3877.7 3900.3 4020.4 4180.5 32194.7 33866.0 33891.8 34040.3 34506.1 4264.2 4289.2 4312.2 4338.2 4372.5 336820.0 341528.0 342967.0 344306.0 346090.0 38716.0 39210.8 64077.4 64351.0 64404.4 40309.4 40326.6 40372.8 40398.4 40493.4 16050.5 16209.7 16233.4 16252.3 16313.8 13529.1 13549.9 13556.0 13556.7 13612.8 9354.9 9365.6 9410.3 9431.7 9453.7 3644.8 3711.7 3715.4 3729.5 3736.6 1189.8 1213.2 1229.2 1254.7 1261.9 30429.7 33688.7 34351.8 34400.3 34490.8 1174.3 1185.7 1233.2 1301.7 1311.7 17441.0 17582.7 17711.8 17763.0 17775.2 499568.0 506374.0 509657.0 518316.0 523480.0 56051.5 57030.0 57129.0 57146.4 57278.7 1485.7 1508.8 1518.5 1545.8 1613.4 31564.0 31740.8 33137.5 35188.3 35615.6 54594.7 54975.2 55072.2 55278.4 55484.4 423419.0 424004.0 424320.0 424860.0 426296.0 30336.2 30574.2 30854.7 31131.0 31281.8 50974.7 51410.5 52025.0 52796.0 53213.2 42935.6 43328.6 43721.3 43907.6 44858.8 42470.4 42796.0 43894.8 44267.3 44761.3 44019.0 44383.3 44436.6 44506.6 45617.5 37867.0 38047.0 38706.3 38764.6 38802.8 29951.9 30342.8 30408.1 30523.2 30560.4 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | [#2] jquery.html Cycles:180 Average:29372.94 Median:2091.26 stddev:86430.42 (4132.9%) stddev-sans-first:86645.51 02:25:03 INFO - PROCESS | 3403 | Values: 405.1 412.5 413.3 413.5 421.0 18675.6 19309.6 19373.6 19508.2 20821.2 20188.4 20575.3 20600.9 20772.1 20777.8 5459.7 5563.2 5636.2 5771.9 5889.6 5735.2 5855.2 5879.6 5889.0 5889.9 5499.7 5758.3 5799.8 5831.2 5835.1 5645.2 5650.1 5704.2 5740.7 5761.8 5481.1 5632.9 5637.7 5657.1 5663.3 13835.4 14053.5 14055.8 14176.2 14181.0 2514.6 2574.4 2578.7 2693.8 3059.2 10010.6 10129.2 10133.6 10380.6 10425.8 2046.4 2056.0 2073.0 2093.7 2114.9 79227.6 82675.6 82707.6 83032.6 83285.6 10030.4 10442.8 11059.4 11174.7 11193.0 14830.3 15153.8 15323.8 15411.8 15485.1 8120.0 8226.5 8354.7 8372.3 8612.9 7724.7 7759.8 7770.4 7803.4 7804.5 4691.0 4738.9 4749.5 4768.9 4884.9 1964.8 2017.8 2048.2 2085.7 2088.8 1014.7 1073.5 1137.0 1137.9 1155.4 16539.0 18740.9 19322.3 19639.4 19831.7 1081.6 1137.5 1142.2 1167.2 1176.9 10833.9 10969.2 10999.0 11054.8 11118.1 517058.0 524153.0 525289.0 532706.0 534442.0 52576.7 59990.0 88462.0 89406.0 90633.0 1093.5 1107.3 1110.3 1116.6 1123.6 17067.1 17188.5 17337.1 17338.7 17428.1 37141.8 37142.8 37898.8 38805.2 38837.6 54421.0 56938.7 57039.4 57657.4 57765.4 8417.1 8484.2 8671.3 8739.8 8792.3 9622.3 12286.9 13433.0 13516.5 14123.2 12214.4 12730.3 13004.6 13045.2 13089.3 12513.3 12544.1 12595.1 12747.4 12751.9 12714.9 13194.8 13259.4 13327.7 13393.3 8878.6 8903.7 8973.9 9041.5 9070.5 9027.8 11318.7 11882.8 11909.3 12017.9 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | [#3] mootools.html Cycles:180 Average:5709.73 Median:5197.16 stddev:3151.45 (60.6%) stddev-sans-first:3145.10 02:25:03 INFO - PROCESS | 3403 | Values: 1592.1 1608.3 1820.1 1915.6 1925.6 8333.1 8441.5 8491.1 8574.4 8581.5 8721.1 8745.3 8770.8 8825.3 8885.6 2357.1 2379.9 2386.9 2391.4 2398.1 2407.3 2415.4 2474.8 2482.6 2484.6 2407.4 2417.1 2437.2 2440.8 2440.9 2367.9 2377.9 2414.3 2424.8 2427.4 2419.0 2474.1 2477.7 2482.7 2487.0 8768.6 8781.6 8830.1 8839.1 8840.5 5205.0 5280.5 5303.1 5316.9 5330.9 3522.5 3551.1 3584.6 3622.0 3670.5 1154.3 1160.5 1175.9 1191.7 1202.2 12027.7 12049.9 12144.3 12151.8 12170.6 4436.4 4539.2 4571.3 4600.5 4616.6 9796.3 9866.7 9866.9 9868.8 9880.0 5239.7 5241.7 5243.1 5261.7 5266.0 4819.3 4930.5 4945.5 4957.4 4975.4 3800.4 3829.7 3883.7 3895.1 3944.9 1129.6 1135.9 1145.9 1174.1 1183.2 923.1 926.8 1033.3 1075.9 1089.2 5984.1 6067.1 6169.3 6223.5 6272.6 466.6 468.6 471.6 472.7 495.8 4229.3 4267.4 4272.6 4305.8 4321.7 10342.1 10574.9 10588.9 10663.7 10709.8 10386.9 10503.2 10531.6 10547.1 10572.6 7841.1 8035.0 8105.3 8134.4 8266.0 5631.7 5641.3 5675.7 5685.7 5743.5 9265.3 9350.4 9414.2 9449.0 9481.7 9231.6 9393.9 9410.7 9432.0 9507.1 6794.4 7451.6 7649.2 7688.7 7778.6 8298.8 8300.0 8312.8 8326.4 8351.8 7058.1 7469.3 7517.2 7523.8 7566.0 7407.7 7418.8 7421.0 7536.5 7569.8 6963.8 6994.7 7098.8 7125.3 7130.8 5189.4 5260.6 5264.8 5364.5 5378.8 5179.8 5186.8 5209.2 5238.9 5245.4 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | [#4] prototype.html Cycles:180 Average:5796.88 Median:6742.11 stddev:1825.88 (27.1%) stddev-sans-first:1784.41 02:25:03 INFO - PROCESS | 3403 | Values: 336.6 337.5 340.0 343.9 348.5 6542.1 6647.3 6658.5 6659.3 6710.9 6558.5 6561.5 6562.6 6568.2 6600.6 4712.2 4749.2 4755.5 4768.2 4773.1 4738.0 4775.7 4787.8 4842.4 4857.0 4757.9 4773.5 4786.9 4802.8 4804.4 4801.9 4810.5 4816.9 4828.2 4832.9 4120.3 4124.9 4125.8 4132.9 4139.5 6077.5 6311.0 6319.2 6319.5 6328.4 5616.1 5642.6 5668.1 5675.9 5687.7 6873.5 6901.9 6918.5 6923.7 6940.4 4625.4 4633.3 4645.2 4655.9 4668.9 7207.4 7267.9 7280.9 7282.1 7287.1 4678.3 4753.0 4758.9 4766.2 4779.8 4781.6 4813.5 4819.7 4826.8 4837.3 5647.0 5648.2 5657.2 5657.2 5666.9 6961.9 6983.8 7023.8 7034.9 7038.6 1680.9 1696.7 1698.8 1704.4 1707.7 1053.2 1074.4 1083.3 1086.4 1105.9 6773.3 6806.3 6807.5 6810.7 6817.0 7116.8 7136.8 7157.5 7163.1 7194.8 6648.7 6821.0 6869.3 6894.7 6902.6 3884.3 3901.4 3904.2 3920.8 3932.2 7578.1 7636.4 7638.3 7641.7 7647.1 7311.3 7438.9 7443.1 7443.9 7453.4 7588.8 7591.5 7592.0 7610.6 7628.8 7253.4 7266.3 7272.1 7280.1 7290.2 7108.3 7141.3 7149.5 7159.5 7177.3 7411.7 7599.4 7617.8 7622.7 7626.6 4698.8 4746.3 4752.3 4752.5 4771.8 7235.1 7245.3 7248.0 7248.2 7259.5 7001.1 7007.5 7016.3 7016.9 7043.8 6822.8 6947.8 6995.2 6996.9 7030.4 6844.6 6879.7 6882.1 6885.1 6894.2 7044.0 7050.2 7050.8 7051.0 7056.9 6853.8 6855.3 6860.3 6860.9 6871.3 02:25:03 INFO - PROCESS | 3403 | 02:25:03 INFO - PROCESS | 3403 | [#5] yui.html Cycles:180 Average:15567.82 Median:4736.17 stddev:17648.89 (372.6%) stddev-sans-first:17664.27 02:25:03 INFO - PROCESS | 3403 | Values: 950.6 952.8 962.0 971.5 981.7 14772.9 15031.2 15031.8 15044.0 15053.9 14428.6 14541.3 14575.9 14584.1 14595.0 763.5 882.4 892.8 893.6 901.2 864.9 866.1 867.7 868.5 868.9 958.1 959.7 959.8 960.1 961.9 949.0 949.5 953.9 954.5 963.0 696.7 702.8 708.2 708.5 709.6 14615.7 14663.4 14689.8 14691.8 14715.5 14368.9 14477.3 14559.1 14577.9 14591.6 12104.8 12431.7 12620.9 12742.0 12976.5 3974.6 3992.6 4021.4 4022.0 4043.0 56202.0 56612.0 57259.4 57392.0 57554.7 11258.4 11598.8 11612.2 11755.1 11914.8 21861.0 22001.4 22001.4 22007.9 22582.3 8784.5 8848.6 8952.1 8969.4 9158.8 4760.8 4859.5 4895.5 4915.7 4932.3 3670.2 3751.3 3754.8 3755.7 3756.9 642.6 646.9 654.6 666.4 670.0 781.0 798.5 813.9 827.6 835.7 9195.9 9228.4 9380.3 9580.7 9591.2 726.3 726.4 738.1 752.1 763.1 4592.4 4598.8 4711.6 4827.5 4865.0 61634.4 63207.4 63375.0 68382.7 68428.7 51499.2 51807.0 51821.5 52813.0 52929.5 49879.0 51102.5 51672.7 52385.0 52507.0 9439.2 9502.6 9579.3 9634.4 10256.6 36162.0 37260.8 38683.4 39137.4 39780.6 46287.8 46565.0 49772.8 50603.2 51853.0 12592.8 12798.3 12984.2 13055.6 13146.8 13841.6 14016.8 14095.6 14525.3 14560.9 13081.5 13224.3 13303.0 13385.7 13593.1 12862.7 13618.3 13626.7 13884.0 14421.4 13266.5 13312.0 13660.6 13890.9 13893.8 10716.4 10753.7 10980.4 11025.2 11064.3 10816.8 10910.8 11038.9 11075.7 11103.6 02:25:03 INFO - PROCESS | 3403 | -------- Summary: end -------- 02:25:03 INFO - PROCESS | 3403 | 02:25:04 INFO - TEST-INFO | 3403: exit 0 02:25:04 INFO - TEST-OK | dromaeo_css | took 1110118ms 02:25:04 INFO - TEST-START | kraken 02:25:04 INFO - operating with platform_type : linux_ 02:25:04 INFO - Initialising browser for kraken test... 02:25:04 INFO - TEST-INFO | started process 3678 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsx_zb/profile http://localhost:39761/getInfo.html) 02:25:08 INFO - PROCESS | 3678 | 02:25:08 INFO - PROCESS | 3678 | (process:3752): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:25:09 INFO - PROCESS | 3678 | __metrics Screen width/height:1600/1200 02:25:09 INFO - PROCESS | 3678 | colorDepth:24 02:25:09 INFO - PROCESS | 3678 | Browser inner width/height: 1024/697 02:25:09 INFO - PROCESS | 3678 | __metrics 02:25:10 ERROR - PROCESS | 3678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:25:11 INFO - TEST-INFO | 3678: exit 0 02:25:11 INFO - Browser initialized. 02:25:11 INFO - Running cycle 1/1 for kraken test... 02:25:11 INFO - TEST-INFO | started process 3802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJsx_zb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:12 INFO - PROCESS | 3802 | 02:25:12 INFO - PROCESS | 3802 | (process:3873): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:25:22 INFO - PROCESS | 3802 | RSS: Main: 151064576 02:25:22 INFO - PROCESS | 3802 | 02:25:25 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39761/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:26 INFO - PROCESS | 3802 | RSS: Main: 156364800 02:25:26 INFO - PROCESS | 3802 | 02:25:28 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39761/tests/kraken/driver.html?testName=audio-dft) 02:25:29 INFO - PROCESS | 3802 | RSS: Main: 156667904 02:25:29 INFO - PROCESS | 3802 | 02:25:32 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39761/tests/kraken/driver.html?testName=audio-fft) 02:25:32 INFO - PROCESS | 3802 | RSS: Main: 156614656 02:25:32 INFO - PROCESS | 3802 | 02:25:35 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39761/tests/kraken/driver.html?testName=audio-oscillator) 02:25:35 INFO - PROCESS | 3802 | RSS: Main: 156835840 02:25:35 INFO - PROCESS | 3802 | 02:25:37 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:38 INFO - PROCESS | 3802 | RSS: Main: 156389376 02:25:38 INFO - PROCESS | 3802 | 02:25:41 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39761/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:42 INFO - PROCESS | 3802 | RSS: Main: 157331456 02:25:42 INFO - PROCESS | 3802 | 02:25:45 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39761/tests/kraken/driver.html?testName=imaging-desaturate) 02:25:46 INFO - PROCESS | 3802 | RSS: Main: 156524544 02:25:46 INFO - PROCESS | 3802 | 02:25:48 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39761/tests/kraken/driver.html?testName=json-parse-financial) 02:25:49 INFO - PROCESS | 3802 | RSS: Main: 156692480 02:25:49 INFO - PROCESS | 3802 | 02:25:50 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:25:51 INFO - PROCESS | 3802 | RSS: Main: 156463104 02:25:51 INFO - PROCESS | 3802 | 02:25:53 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:25:53 INFO - PROCESS | 3802 | RSS: Main: 155934720 02:25:53 INFO - PROCESS | 3802 | 02:25:56 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:25:57 INFO - PROCESS | 3802 | RSS: Main: 157249536 02:25:57 INFO - PROCESS | 3802 | 02:25:59 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:00 INFO - PROCESS | 3802 | RSS: Main: 157265920 02:26:00 INFO - PROCESS | 3802 | 02:26:03 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:03 INFO - PROCESS | 3802 | RSS: Main: 157405184 02:26:03 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:39761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39761/tests/kraken/driver.html?testName=ai-astar) 02:26:05 INFO - PROCESS | 3802 | RSS: Main: 158498816 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | __start_tp_report 02:26:05 INFO - PROCESS | 3802 | _x_x_mozilla_page_load 02:26:05 INFO - PROCESS | 3802 | _x_x_mozilla_page_load_details 02:26:05 INFO - PROCESS | 3802 | |i|pagename|runs| 02:26:05 INFO - PROCESS | 3802 | |0;ai-astar;114;105;110;110;111;122;110;112;112;111 02:26:05 INFO - PROCESS | 3802 | |1;audio-beat-detection;157;126;151;174;138;157;150;138;194;135 02:26:05 INFO - PROCESS | 3802 | |2;audio-dft;164;161;164;165;166;162;163;169;162;161 02:26:05 INFO - PROCESS | 3802 | |3;audio-fft;75;76;72;176;76;76;76;74;165;76 02:26:05 INFO - PROCESS | 3802 | |4;audio-oscillator;92;93;151;92;92;94;152;92;91;149 02:26:05 INFO - PROCESS | 3802 | |5;imaging-gaussian-blur;118;117;117;117;118;118;117;117;117;117 02:26:05 INFO - PROCESS | 3802 | |6;imaging-darkroom;147;146;147;145;147;146;146;146;145;148 02:26:05 INFO - PROCESS | 3802 | |7;imaging-desaturate;97;95;96;95;95;95;95;95;95;96 02:26:05 INFO - PROCESS | 3802 | |8;json-parse-financial;54;55;54;54;56;57;55;76;53;52 02:26:05 INFO - PROCESS | 3802 | |9;json-stringify-tinderbox;59;59;58;60;60;59;61;59;60;60 02:26:05 INFO - PROCESS | 3802 | |10;stanford-crypto-aes;80;72;72;82;76;74;74;75;76;80 02:26:05 INFO - PROCESS | 3802 | |11;stanford-crypto-ccm;116;123;114;122;110;114;118;118;127;132 02:26:05 INFO - PROCESS | 3802 | |12;stanford-crypto-pbkdf2;168;161;169;161;165;174;163;164;162;159 02:26:05 INFO - PROCESS | 3802 | |13;stanford-crypto-sha256-iterative;71;68;67;69;69;68;64;70;66;66 02:26:05 INFO - PROCESS | 3802 | __end_tp_report 02:26:05 INFO - PROCESS | 3802 | __start_cc_report 02:26:05 INFO - PROCESS | 3802 | _x_x_mozilla_cycle_collect,846 02:26:05 INFO - PROCESS | 3802 | __end_cc_report 02:26:05 INFO - PROCESS | 3802 | __startTimestamp1465291565782__endTimestamp 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | ------- Summary: start ------- 02:26:05 INFO - PROCESS | 3802 | Number of tests: 14 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.30 (3.9%) stddev-sans-first:4.48 02:26:05 INFO - PROCESS | 3802 | Values: 114.0 105.0 110.0 110.0 111.0 122.0 110.0 112.0 112.0 111.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:154.00 stddev:20.17 (13.1%) stddev-sans-first:21.31 02:26:05 INFO - PROCESS | 3802 | Values: 157.0 126.0 151.0 174.0 138.0 157.0 150.0 138.0 194.0 135.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.50 (1.5%) stddev-sans-first:2.65 02:26:05 INFO - PROCESS | 3802 | Values: 164.0 161.0 164.0 165.0 166.0 162.0 163.0 169.0 162.0 161.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:40.32 (53.0%) stddev-sans-first:42.16 02:26:05 INFO - PROCESS | 3802 | Values: 75.0 76.0 72.0 176.0 76.0 76.0 76.0 74.0 165.0 76.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.22 (30.7%) stddev-sans-first:29.19 02:26:05 INFO - PROCESS | 3802 | Values: 92.0 93.0 151.0 92.0 92.0 94.0 152.0 92.0 91.0 149.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 02:26:05 INFO - PROCESS | 3802 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 02:26:05 INFO - PROCESS | 3802 | Values: 147.0 146.0 147.0 145.0 147.0 146.0 146.0 146.0 145.0 148.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.44 02:26:05 INFO - PROCESS | 3802 | Values: 97.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:55.00 stddev:6.96 (12.7%) stddev-sans-first:7.32 02:26:05 INFO - PROCESS | 3802 | Values: 54.0 55.0 54.0 54.0 56.0 57.0 55.0 76.0 53.0 52.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:60.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 02:26:05 INFO - PROCESS | 3802 | Values: 59.0 59.0 58.0 60.0 60.0 59.0 61.0 59.0 60.0 60.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:3.48 (4.6%) stddev-sans-first:3.39 02:26:05 INFO - PROCESS | 3802 | Values: 80.0 72.0 72.0 82.0 76.0 74.0 74.0 75.0 76.0 80.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:120.00 stddev:6.65 (5.5%) stddev-sans-first:6.94 02:26:05 INFO - PROCESS | 3802 | Values: 116.0 123.0 114.0 122.0 110.0 114.0 118.0 118.0 127.0 132.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:4.55 (2.8%) stddev-sans-first:4.66 02:26:05 INFO - PROCESS | 3802 | Values: 168.0 161.0 169.0 161.0 165.0 174.0 163.0 164.0 162.0 159.0 02:26:05 INFO - PROCESS | 3802 | 02:26:05 INFO - PROCESS | 3802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:2.10 (3.1%) stddev-sans-first:1.88 02:26:05 INFO - PROCESS | 3802 | Values: 71.0 68.0 67.0 69.0 69.0 68.0 64.0 70.0 66.0 66.0 02:26:05 INFO - PROCESS | 3802 | -------- Summary: end -------- 02:26:05 INFO - PROCESS | 3802 | 02:26:06 INFO - TEST-INFO | 3802: exit 0 02:26:06 INFO - TEST-OK | kraken | took 62391ms 02:26:06 INFO - SUITE-END | took 1172s 02:26:06 INFO - Completed test suite (00:19:32) 02:26:06 INFO - javascript benchmark 02:26:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.3519463704574, 3368.831558422078, 3371.022403502984, 3390.7456940729435, 3406.778559393639, 5603.915941260884, 5616.887662246752, 5627.549796016319, 5645.407232240617, 5663.490285874275, 5624.465675760806, 5643.0, 5650.5479561635075, 5652.152177173416, 5654.773809047643, 5095.439501654824, 5119.59043276537, 5134.666246693953, 5149.0731668299695, 5220.791168353261, 4872.3422337984275, 4939.728314942695, 5084.923726144111, 5108.157154069574, 5155.046316431453, 5063.265826455162, 5079.187330027178, 5086.287919691246, 5087.56755675768, 5152.124138896378, 5119.513646203604, 5123.795048198068, 5126.487351264881, 5134.435212126663, 5147.974260128713, 4907.043126590316, 4946.233333833262, 4988.65079444439, 5042.949570504321, 5062.721550314731, 5327.680339179623, 5354.973225133888, 5356.7321633918145, 5371.382291036542, 5380.677159370451, 5820.82537523875, 5828.504577110951, 5829.271341082364, 5834.533237341003, 5853.473187413153, 5885.529157667419, 5917.6449413034925, 5933.495652869468, 5974.283086029661, 6002.699865006733, 5662.688552129631, 5690.857728556778, 5693.487586117228, 5695.487406133468, 5700.9429905701245, 6047.123167140828, 6184.6598437086395, 6226.719797609027, 6247.437730604267, 6251.468625166821, 5882.529397648178, 5894.233749612523, 5911.083782013795, 5917.437843404869, 5917.55618328627, 5941.168236446901, 5960.344362120163, 5962.195103661037, 5964.85087872798, 5971.880562388728, 5667.376588575254, 5750.884982300414, 5923.4668879800165, 5934.198883150806, 5962.493188078975, 5930.822075337746, 5971.373005834324, 5977.0, 5978.970105149447, 6014.48876845473, 4489.0572979674635, 4545.045540436479, 4551.817927282872, 4573.794179261941, 4582.945922437858, 3977.2642061218767, 4001.079751657135, 4116.5060192777055, 4118.341065429577, 4135.31767258405, 5719.628224165499, 5815.592908496449, 5822.854428639318, 5837.09525023622, 5893.3222679391565, 5971.611845230046, 5982.7008649568215, 6016.2479690038745, 6022.277326720821, 6050.6974651267265, 5542.778288868481, 5724.284464441945, 5788.739506722208, 5815.0, 5834.3290521589715, 4951.10880041596, 5016.197408414636, 5029.1953287473825, 5054.974725126351, 5058.988202359543, 6250.874982500324, 6294.087357333253, 6302.810915672537, 6305.464035556937, 6317.778877739257, 5825.563082768725, 5893.823185304276, 5951.3751056139345, 6021.759129634941, 6064.666443345658, 5969.492593129633, 5992.98119319708, 6201.10084037821, 6231.376862313732, 6343.048542718445, 5789.710514474175, 5799.217105690846, 5799.913001305068, 5804.9709751452665, 5854.268216472941, 5806.129080637938, 5852.707364631837, 5860.941390586039, 5898.026825573732, 5898.852528686817, 5785.218995435563, 5842.620229685057, 5877.617954832922, 5907.3797251288, 5945.435183657719, 5687.658740475585, 5689.687067211343, 5692.51613612831, 5694.572907032072, 5698.088305871041, 5594.300712410949, 5617.157426386075, 5618.747156377891, 5638.9436105638415, 5658.688772117573, 5945.881082378415, 5947.137665038459, 5983.670898100646, 5995.130706047511, 5998.670073146019, 5795.507381872588, 5807.767689292381, 5824.679642619697, 5824.854378640398, 5834.883302334015], "value": 5504.850280578972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.4496457869125, 686.9313068693132, 707.7770502291775, 746.1307576673178, 791.5290402210683, 39480.0, 40668.38997415038, 40730.18539629206, 40775.592244077554, 40792.18415631686, 41168.38247426291, 41817.0, 41923.0, 41968.370474442905, 42151.0, 8907.242884354837, 9122.22461090808, 9155.359124861263, 9161.267098632094, 9179.127982841619, 8957.507337096456, 9023.864642030374, 9039.0, 9042.819143617124, 9072.00207977122, 9044.457332560067, 9097.0, 9119.088091190893, 9138.040505746867, 9176.082391760838, 9040.954795226015, 9044.3668943174, 9100.226480749145, 9118.316126290489, 9135.451872887648, 8992.685256016073, 9065.41074830134, 9116.270698344117, 9120.407173533766, 9142.58858351369, 42039.57960420418, 42382.78808605968, 42433.0, 42528.57471425277, 44469.0, 3847.5960024197334, 3877.689784817208, 3900.278448487039, 4020.356742921148, 4180.456540649727, 32194.678053219635, 33866.0, 33891.83054084738, 34040.31919361624, 34506.137346566284, 4264.189803937273, 4289.206496798102, 4312.159128969852, 4338.197433474786, 4372.497162826252, 336820.0, 341528.0, 342967.0, 344306.0, 346090.0, 38716.0, 39210.803945980086, 64077.35922640714, 64351.0, 64404.35595643984, 40309.39535906964, 40326.59673403287, 40372.79813600913, 40398.39402408966, 40493.39259911104, 16050.518484445485, 16209.67580648404, 16233.431829886133, 16252.268647910872, 16313.83686163147, 13529.120607160503, 13549.932250338883, 13556.0, 13556.661083472993, 13612.795808062887, 9354.859677104849, 9365.578548965314, 9410.294227932933, 9431.669891553762, 9453.66912158085, 3644.817759112034, 3711.684506816897, 3715.3869611514338, 3729.5151630287887, 3736.5889752127246, 1189.8334233207358, 1213.1932265043824, 1229.244014930829, 1254.6737848159362, 1261.8864302212844, 30429.69570304313, 33688.663113369046, 34351.82824085864, 34400.311993759984, 34490.82754586211, 1174.2602160638744, 1185.7154282972024, 1233.1860971758776, 1301.7266374061553, 1311.731095125497, 17441.0, 17582.73625895587, 17711.822881771273, 17763.0, 17775.200115994812, 499568.0, 506374.0, 509657.0, 518316.0, 523480.0, 56051.47768350434, 57030.0, 57129.0, 57146.42853571494, 57278.7136064317, 1485.7474229381248, 1508.8038554987781, 1518.5216656753307, 1545.7526795712631, 1613.4191690991233, 31564.0, 31740.841295793372, 33137.50293745644, 35188.29623407466, 35615.643843561236, 54594.72702636461, 54975.17537236865, 55072.17391739207, 55278.44721552894, 55484.445155547925, 423419.0, 424004.0, 424320.0, 424860.0, 426296.0, 30336.241593960327, 30574.235644109074, 30854.691453085183, 31131.0, 31281.8435907819, 50974.74512627413, 51410.48589514057, 52025.0, 52796.0, 53213.20180197222, 42935.62206015471, 43328.56671433371, 43721.34417983669, 43907.560924390345, 44858.77570612126, 42470.36294455647, 42796.0, 43894.780526098446, 44267.33598995953, 44761.328580071975, 44019.0, 44383.334249986925, 44436.555634444536, 44506.55493445154, 45617.54382456133, 37867.0, 38047.0, 38706.2576784367, 38764.61235387723, 38802.80598596989, 29951.850240748656, 30342.84828575843, 30408.087757367313, 30523.2369190772, 30560.388792224476], "value": 19867.132878949553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.0683428115334, 412.4617374326503, 413.27057743083463, 413.45630495897893, 420.98947526311855, 18675.62648747026, 19309.613807723836, 19373.612527749454, 19508.21967121317, 20821.167153313887, 20188.394348169542, 20575.27986520472, 20600.89699551504, 20772.06525706343, 20777.792222077813, 5459.727013649322, 5563.221149039117, 5636.210930469727, 5771.884562308751, 5889.646621202742, 5735.168400581913, 5855.151003104547, 5879.559033072515, 5889.02831032879, 5889.911651325234, 5499.7250137493165, 5758.280214973129, 5799.768009279624, 5831.241938548004, 5835.095560188178, 5645.181448689958, 5650.0959846424375, 5704.172894930232, 5740.684262365589, 5761.82714518563, 5481.095619222823, 5632.915506267409, 5637.746301416446, 5657.066584013633, 5663.292088488939, 13835.446582136703, 14053.508127215498, 14055.78916316256, 14176.220307883063, 14181.0, 2514.6353778701987, 2574.4464940037983, 2578.742125787425, 2693.8114331996767, 3059.189314831571, 10010.649627263083, 10129.240306976932, 10133.645322413753, 10380.636677716318, 10425.843612345821, 2046.3963130876277, 2056.043939568108, 2072.9792702072937, 2093.7382827146607, 2114.925977590792, 79227.6038619809, 82675.5866220671, 82707.5864620679, 83032.58483707604, 83285.58357208176, 10030.44832534203, 10442.791144177074, 11059.447027648584, 11174.66476005721, 11193.0, 14830.33263503145, 15153.848461515465, 15323.770143447857, 15411.845881541265, 15485.148316842682, 8120.0, 8226.547539885363, 8354.749357519284, 8372.288355489729, 8612.913870861212, 7724.6523906424345, 7759.7672069838, 7770.41721870862, 7803.375729941591, 7804.531728096333, 4691.0, 4738.857834264978, 4749.453812811502, 4768.928466073012, 4884.877878053006, 1964.7818352621466, 2017.8083082107175, 2048.2114385961513, 2085.738128432307, 2088.7806780288156, 1014.7158795537262, 1073.4954571351452, 1136.9545218191345, 1137.9203455758018, 1155.399192419937, 16539.0, 18740.906295468434, 19322.32371866978, 19639.410817675493, 19831.702524462144, 1081.5944020992129, 1137.5222406589253, 1142.2404101272728, 1167.1538134852333, 1176.9352685602373, 10833.891661083446, 10969.23215374932, 10999.0, 11054.834177487344, 11118.110551155889, 517058.0, 524153.0, 525289.0, 532706.0, 534442.0, 52576.73711631417, 59990.0, 88462.0, 89406.0, 90633.0, 1093.4805967165692, 1107.3134656512852, 1110.3116068037868, 1116.6036057199576, 1123.5955056179769, 17067.06131162798, 17188.484345469657, 17337.133143343035, 17338.653226935643, 17428.128593570018, 37141.81429092837, 37142.8142859284, 37898.810505947295, 38805.2238955225, 38837.61162388453, 54421.0, 56938.715306423204, 57039.429605703415, 57657.423425765206, 57765.422345776, 8417.116202798863, 8484.23477086809, 8671.34964877624, 8739.781505462413, 8792.252658523841, 9622.326437149331, 12286.938565307117, 13433.0, 13516.459341626225, 14123.152610843383, 12214.389280536116, 12730.299833509245, 13004.609861704164, 13045.217286962812, 13089.280089594782, 12513.311767852856, 12544.059195560187, 12595.05537084704, 12747.362631868184, 12751.872481275068, 12714.87285127137, 13194.80207796903, 13259.403326850123, 13327.66680832987, 13393.330333483482, 8878.595636570673, 8903.688370906988, 8973.910260897308, 9041.502717350346, 9070.455772653662, 9027.774305642411, 11318.660440186808, 11882.82175767347, 11909.344986025852, 12017.879821201675], "value": 9287.84292349118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1592.0845513829547, 1608.332541995072, 1820.1263393571085, 1915.5689969756797, 1925.5571218619716, 8333.083360830304, 8441.493510389366, 8491.0659827419, 8574.442661227016, 8581.52801595912, 8721.12788721129, 8745.256653184488, 8770.824583508342, 8825.293976481882, 8885.644574217024, 2357.127862690807, 2379.9048038078454, 2386.880655967195, 2391.3782416571644, 2398.136670798511, 2407.2898494943947, 2415.384077060347, 2474.75252474752, 2482.553140434721, 2484.5776218042884, 2407.3620490570015, 2417.1177520205174, 2437.2322718343667, 2440.792532634728, 2440.8779561021965, 2367.881605919697, 2377.857328560292, 2414.311921102486, 2424.7938925191293, 2427.4295540548046, 2419.0444774314046, 2474.072222916406, 2477.677901872763, 2482.6648402465617, 2486.950260994788, 8768.561571921442, 8781.56092195394, 8830.116988301183, 8839.07189745074, 8840.513771742551, 5204.959008198375, 5280.471952804727, 5303.098473259555, 5316.946830531722, 5330.92003619946, 3522.4716292556063, 3551.094470909927, 3584.5698516177963, 3622.0, 3670.4861319415304, 1154.2612727854096, 1160.5067846165346, 1175.935323557204, 1191.6603767926185, 1202.1705023533734, 12027.699307517294, 12049.939750301193, 12144.271343719316, 12151.756964860653, 12170.57402990891, 4436.3567282743825, 4539.228331183706, 4571.291449825282, 4600.5169457207185, 4616.561426664462, 9796.314258002014, 9866.654667086617, 9866.851997220047, 9868.80262394748, 9880.0, 5239.73801309933, 5241.68549887008, 5243.056249875059, 5261.657992230493, 5265.973670131625, 4819.277108433693, 4930.457649658535, 4945.505449455098, 4957.380327459067, 4975.353204083518, 3800.3539398302355, 3829.6744776693736, 3883.728139030241, 3895.0651843557343, 3944.901377465529, 1129.5989923577176, 1135.9261647992853, 1145.9083273338113, 1174.1135442740676, 1183.1776915044134, 923.0630909626734, 926.8424367857481, 1033.2921948465325, 1075.870895492546, 1089.2375337263788, 5984.072468767348, 6067.089936509471, 6169.290531588925, 6223.471004964538, 6272.560920735505, 466.55677106748726, 468.63914785614884, 471.617989428564, 472.7258190249647, 495.8165478772877, 4229.2598795210715, 4267.4025636410925, 4272.636825869836, 4305.84929527465, 4321.69748117635, 10342.069213770797, 10574.89425105739, 10588.947055264674, 10663.680089597325, 10709.839352409721, 10386.948065259776, 10503.2122590806, 10531.57873685044, 10547.103496202908, 10572.629957951434, 7841.137474877759, 8034.995625546923, 8105.311048560939, 8134.430589858653, 8266.04940431846, 5631.662100273997, 5641.26663533738, 5675.68783716883, 5685.658860468385, 5743.511801496919, 9265.305102117234, 9350.438973661601, 9414.246860251027, 9448.96061433228, 9481.66814161501, 9231.58457869384, 9393.85909211376, 9410.717678469657, 9431.952840235756, 9507.096825801538, 6794.3545363190415, 7451.552906825608, 7649.158592554926, 7688.692452301845, 7778.649960751893, 8298.792530186794, 8299.958500207702, 8312.792180195544, 8326.417150799385, 8351.832963340821, 7058.11773528309, 7469.327760501581, 7517.248275172439, 7523.774286771406, 7566.0, 7407.66665500043, 7418.812989921803, 7421.0, 7536.472446928662, 7569.848603028019, 6963.79108626742, 6994.685239164148, 7098.787036388917, 7125.287471252833, 7130.750423735144, 5189.351331083614, 5260.552853007537, 5264.763085661231, 5364.544013758718, 5378.784848606168, 5179.81870634526, 5186.766595503136, 5209.192575150858, 5238.895222095613, 5245.396779370421], "value": 4559.277835026482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6162574664881, 337.5038693121112, 340.04447502517917, 343.9019879334389, 348.48946293679757, 6542.084108224853, 6647.335266473357, 6658.533902626812, 6659.300773418794, 6710.899336509956, 6558.508111891615, 6561.475081993441, 6562.573432726869, 6568.211814582245, 6600.636964966925, 4712.222483290261, 4749.216379297429, 4755.45312289086, 4768.23708206687, 4773.140834649762, 4737.976310118462, 4775.689580177294, 4787.8324258650955, 4842.418909730837, 4856.97571512142, 4757.857264282077, 4773.522647735216, 4786.880327991793, 4802.783874725628, 4804.37543119394, 4801.855944321658, 4810.518948105197, 4816.8554943351755, 4828.227483602642, 4832.855014349575, 4120.25835349637, 4124.876253712393, 4125.814338354751, 4132.91734165318, 4139.503259608866, 6077.453029227391, 6310.9684451577905, 6319.178506794087, 6319.494440444753, 6328.3988021138375, 5616.129499927518, 5642.605017648766, 5668.149777533362, 5675.9432405675825, 5687.744051517691, 6873.518853680244, 6901.896471552931, 6918.515703900729, 6923.723051077951, 6940.444764418834, 4625.444946606429, 4633.328167415706, 4645.210314246586, 4655.86032419028, 4668.883277918046, 7207.423406127497, 7267.927320726778, 7280.890786638205, 7282.05333306672, 7287.125544934589, 4678.3216433616935, 4753.0, 4758.928616070762, 4766.213574760126, 4779.808807647655, 4781.569658730731, 4813.470518242991, 4819.662623616313, 4826.782794774173, 4837.32277481153, 5647.0, 5648.15277708347, 5657.20799088128, 5657.20799088128, 5666.943330566724, 6961.860762784716, 6983.790486285419, 7023.754168604074, 7034.92965070353, 7038.612876291853, 1680.932762689503, 1696.6691495158573, 1698.8471037606676, 1704.3608646757466, 1707.709689352813, 1053.2364036073784, 1074.3929679730927, 1083.3012706804068, 1086.375334182848, 1105.90599799018, 6773.322667733188, 6806.285340039323, 6807.4894382921475, 6810.693518791666, 6816.965915170393, 7116.786496405116, 7136.750213742494, 7157.534760240567, 7163.06880105583, 7194.784156475314, 6648.66756662165, 6820.965895170492, 6869.313068693091, 6894.689738961759, 6902.585844849325, 3884.3396622574232, 3901.395283731026, 3904.2191561687778, 3920.843166273374, 3932.1545867638597, 7578.12851522071, 7636.3890888728765, 7638.274363935418, 7641.69433222676, 7647.082350118021, 7311.341979221789, 7438.925610743823, 7443.144038435541, 7443.8883416748795, 7453.366463850633, 7588.848223035508, 7591.544507329468, 7591.962040189764, 7610.6194690265265, 7628.80927976805, 7253.419726421768, 7266.273372662903, 7272.05463289769, 7280.089988751406, 7290.161631412243, 7108.324709152622, 7141.321574450419, 7149.499535032706, 7159.463040271896, 7177.282271772781, 7411.740589079356, 7599.392048635986, 7617.809554761176, 7622.69509219625, 7626.6186690664135, 4698.835540756194, 4746.311784791255, 4752.287156926489, 4752.5485078917445, 4771.785269662804, 7235.095613048369, 7245.311695388929, 7247.9637601811655, 7248.238934911758, 7259.52813067149, 7001.124859392576, 7007.509474336747, 7016.333448322402, 7016.894746578908, 7043.823904402431, 6822.761203357859, 6947.756828510978, 6995.230524642184, 6996.860062798613, 7030.367266945999, 6844.623545704835, 6879.724811007503, 6882.139732533434, 6885.070515480346, 6894.172699276119, 7044.049053377728, 7050.189228238613, 7050.8237294066, 7051.0, 7056.894146587908, 6853.760118395832, 6855.348741869514, 6860.3139686031, 6860.862782744417, 6871.3128687132885], "value": 5187.723309256426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [950.5817440326256, 952.8427809411445, 961.95190240488, 971.4754032822276, 981.730024243333, 14772.852271477283, 15031.248437578131, 15031.774523382159, 15044.0, 15053.92473037636, 14428.639284017905, 14541.34563944625, 14575.854241457582, 14584.124952502858, 14595.0, 763.4541302968377, 882.4440602420498, 892.7589550821274, 893.5621545442751, 901.2069378946518, 864.9264812490945, 866.1425189062845, 867.652938824469, 868.535333596526, 868.8696695495663, 958.1041725986225, 959.6737109382808, 959.755262408085, 960.1454705312243, 961.9086186812242, 948.9905100949005, 949.4920217683506, 953.9141477267044, 954.5322791831987, 963.0177219236409, 696.7004188199072, 702.7891632510226, 708.2244941788733, 708.518207618819, 709.6274455910689, 14615.70768584633, 14663.41346346145, 14689.77965330521, 14691.77962330566, 14715.484958026418, 14368.856311436857, 14477.276136193253, 14559.12645241289, 14577.854221457756, 14591.635209119751, 12104.81842772359, 12431.689207769788, 12620.936895315464, 12742.0, 12976.545820896317, 3974.642282194616, 3992.640662340374, 4021.3565829467143, 4022.0, 4043.0296728785174, 56202.0, 56612.0, 57259.42740572582, 57392.0, 57554.71222643902, 11258.43707814606, 11598.76802463946, 11612.245204061708, 11755.118366122575, 11914.821277680841, 21861.0, 22001.449963750714, 22001.449963750714, 22007.889960550096, 22582.322530324116, 8784.516851573226, 8848.557572121368, 8952.104789521127, 8969.416987895765, 9158.771030724285, 4760.7619619018915, 4859.514048595112, 4895.485973972753, 4915.729634870117, 4932.334134891744, 3670.1925576373155, 3751.324761542894, 3754.8310326035394, 3755.7370984030854, 3756.868509602151, 642.6369101457755, 646.8835609590319, 654.5974225851068, 666.4068978609042, 670.045185610503, 781.004219619989, 798.4969469234461, 813.8901248331399, 827.6234313387515, 835.6699103854065, 9195.862062069074, 9228.446293222294, 9380.343375963754, 9580.66467673628, 9591.232701383873, 726.2555880222814, 726.440640706653, 738.0516036892567, 752.1162633905249, 763.0804880119442, 4592.402987611589, 4598.816047358068, 4711.575958163782, 4827.468978412372, 4865.0, 61634.38365616376, 63207.367926321065, 63375.0, 68382.65808671025, 68428.65785671139, 51499.227511587356, 51807.0, 51821.48178518166, 52813.0, 52929.47070529246, 49879.0, 51102.48897510977, 51672.741636291576, 52384.999999999236, 52507.0, 9439.15973047948, 9502.61989520439, 9579.329446938926, 9634.421934683662, 10256.641017564349, 36162.0, 37260.81369593243, 38683.41974870323, 39137.41293880537, 39780.60219397769, 46287.768561156976, 46565.0, 49772.75113624553, 50603.2409513865, 51853.0, 12592.811107833573, 12798.296093714935, 12984.15602985803, 13055.608331750063, 13146.802797957847, 13841.584752457442, 14016.844962478224, 14095.577132686036, 14525.27373631293, 14560.85439145595, 13081.477866366356, 13224.338783060615, 13303.0, 13385.66535836612, 13593.116447430886, 12862.742745145231, 13618.250996195304, 13626.727465450835, 13884.0, 14421.351039203471, 13266.469341226242, 13312.0, 13660.590182294547, 13890.930545347208, 13893.791593125909, 10716.35701857891, 10753.731156721145, 10980.396078215455, 11025.17311201647, 11064.28082174656, 10816.837747433952, 10910.836337455103, 11038.889611103787, 11075.667729968114, 11103.611373601885], "value": 7217.043815996152, "unit": "score"}], "name": "dromaeo_css", "value": 7467.5403831743715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 110.0, 110.0, 111.0, 122.0, 110.0, 112.0, 112.0, 111.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 151.0, 174.0, 138.0, 157.0, 150.0, 138.0, 194.0, 135.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 164.0, 165.0, 166.0, 162.0, 163.0, 169.0, 162.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 72.0, 176.0, 76.0, 76.0, 76.0, 74.0, 165.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 151.0, 92.0, 92.0, 94.0, 152.0, 92.0, 91.0, 149.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 146.0, 146.0, 145.0, 148.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 56.0, 57.0, 55.0, 76.0, 53.0, 52.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 60.0, 60.0, 59.0, 61.0, 59.0, 60.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 72.0, 72.0, 82.0, 76.0, 74.0, 74.0, 75.0, 76.0, 80.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 123.0, 114.0, 122.0, 110.0, 114.0, 118.0, 118.0, 127.0, 132.0], "value": 119.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 169.0, 161.0, 165.0, 174.0, 163.0, 164.0, 162.0, 159.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 69.0, 69.0, 68.0, 64.0, 70.0, 66.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1534.3999999999999, "alertThreshold": 2.0}]} 02:26:07 INFO - Return code: 0 02:26:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:26:07 ERROR - # TBPL SUCCESS # 02:26:07 INFO - Running post-action listener: _resource_record_post_action 02:26:07 INFO - Running post-run listener: _resource_record_post_run 02:26:08 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 10059776; Write bytes: 352677888; Read time: 2656; Write time: 387320 02:26:08 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 15601664; Read time: 0; Write time: 13460 02:26:08 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8298496; Write bytes: 337072128; Read time: 2548; Write time: 373452 02:26:08 INFO - Running post-run listener: _upload_blobber_files 02:26:08 INFO - Blob upload gear active. 02:26:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:08 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 02:26:08 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'] 02:26:08 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 02:26:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:26:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:26:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:10 INFO - (blobuploader) - INFO - Done attempting. 02:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:11 INFO - (blobuploader) - INFO - Done attempting. 02:26:11 INFO - (blobuploader) - INFO - Iteration through files over. 02:26:11 INFO - Return code: 0 02:26:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:26:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:26:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb0df10d3c0d29bc5c432d26644e9df2bca5c24a2d1c96cf1016115ac044c0077e009e4784b5e2bdf565944eef478c7f9ba28c460c209433b725872d4224a0a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140bc03e09514a5c8c3b7368c6daf42b1c1443861bb816f415d3fbc923f6fde2debec070f8eca570dcbbd243b04483191cdffd00f08608fcc1e7cd456b765bc2"} 02:26:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:26:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:26:11 INFO - Contents: 02:26:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cb0df10d3c0d29bc5c432d26644e9df2bca5c24a2d1c96cf1016115ac044c0077e009e4784b5e2bdf565944eef478c7f9ba28c460c209433b725872d4224a0a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140bc03e09514a5c8c3b7368c6daf42b1c1443861bb816f415d3fbc923f6fde2debec070f8eca570dcbbd243b04483191cdffd00f08608fcc1e7cd456b765bc2"} 02:26:11 INFO - Running post-run listener: copy_logs_to_upload_dir 02:26:11 INFO - Copying logs to upload dir... 02:26:11 INFO - mkdir: /builds/slave/test/build/upload/logs 02:26:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.939255 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-07 02:26:11.445977) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:11.449183) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220 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/cb0df10d3c0d29bc5c432d26644e9df2bca5c24a2d1c96cf1016115ac044c0077e009e4784b5e2bdf565944eef478c7f9ba28c460c209433b725872d4224a0a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140bc03e09514a5c8c3b7368c6daf42b1c1443861bb816f415d3fbc923f6fde2debec070f8eca570dcbbd243b04483191cdffd00f08608fcc1e7cd456b765bc2"} build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/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/cb0df10d3c0d29bc5c432d26644e9df2bca5c24a2d1c96cf1016115ac044c0077e009e4784b5e2bdf565944eef478c7f9ba28c460c209433b725872d4224a0a4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/140bc03e09514a5c8c3b7368c6daf42b1c1443861bb816f415d3fbc923f6fde2debec070f8eca570dcbbd243b04483191cdffd00f08608fcc1e7cd456b765bc2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:11.477372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:11.478146) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465290322.251115-1048523220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:11.559552) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:26:11.560260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:26:11.560655) ========= ========= Total master_lag: 0.17 =========