builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1465290426.66 results: success (0) buildid: 20160606194329 builduid: 3d31ab4f42854c829e06ac6160cc676b revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.663325) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.664313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.665025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.682119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.682726) ========= 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=836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:07:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-06-07 02:07:07 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.811789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.812493) ========= 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=836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018750 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.866757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:06.867538) ========= 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=836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:07:07,722 truncating revision to first 12 chars 2016-06-07 02:07:07,722 Setting DEBUG logging. 2016-06-07 02:07:07,722 attempt 1/10 2016-06-07 02:07:07,722 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:07:08,052 unpacking tar archive at: mozilla-beta-1f9f6bdee31c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673713 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:07.556872) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:07.557247) ========= script_repo_revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:07.557739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:07.558052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:07.567382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-07 02:07:07.567720) ========= /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=836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:07:08 INFO - MultiFileLogger online at 20160607 02:07:08 in /builds/slave/test 02:07:08 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:07:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:08 INFO - {'append_to_log': False, 02:07:08 INFO - 'base_work_dir': '/builds/slave/test', 02:07:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:07:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:08 INFO - 'branch': 'Mozilla-Beta', 02:07:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:08 INFO - 'config_files': ('talos/linux_config.py',), 02:07:08 INFO - 'default_actions': ('clobber', 02:07:08 INFO - 'read-buildbot-config', 02:07:08 INFO - 'download-and-extract', 02:07:08 INFO - 'populate-webroot', 02:07:08 INFO - 'create-virtualenv', 02:07:08 INFO - 'install', 02:07:08 INFO - 'run-tests'), 02:07:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:08 INFO - 'download_minidump_stackwalk': True, 02:07:08 INFO - 'download_symbols': 'ondemand', 02:07:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:08 INFO - 'installer_path': 'installer.exe', 02:07:08 INFO - 'log_level': 'info', 02:07:08 INFO - 'log_name': 'talos', 02:07:08 INFO - 'log_to_console': True, 02:07:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:07:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:07:08 INFO - 'opt_config_files': (), 02:07:08 INFO - 'pip_index': False, 02:07:08 INFO - 'sps_profile': False, 02:07:08 INFO - 'sps_profile_interval': 0, 02:07:08 INFO - 'suite': 'dromaeojs-e10s', 02:07:08 INFO - 'system_bits': '32', 02:07:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:08 INFO - 'title': 'talos-linux64-ix-028', 02:07:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:08 INFO - 'use_talos_json': True, 02:07:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:08 INFO - 'work_dir': 'build'} 02:07:08 INFO - ##### 02:07:08 INFO - ##### Running clobber step. 02:07:08 INFO - ##### 02:07:08 INFO - Running pre-action listener: _resource_record_pre_action 02:07:08 INFO - Running main action method: clobber 02:07:08 INFO - rmtree: /builds/slave/test/build 02:07:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:09 INFO - Running post-action listener: _resource_record_post_action 02:07:09 INFO - ##### 02:07:09 INFO - ##### Running read-buildbot-config step. 02:07:09 INFO - ##### 02:07:09 INFO - Running pre-action listener: _resource_record_pre_action 02:07:09 INFO - Running main action method: read_buildbot_config 02:07:09 INFO - Using buildbot properties: 02:07:09 INFO - { 02:07:09 INFO - "project": "", 02:07:09 INFO - "product": "firefox", 02:07:09 INFO - "script_repo_revision": "production", 02:07:09 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 02:07:09 INFO - "repository": "", 02:07:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 02:07:09 INFO - "buildid": "20160606194329", 02:07:09 INFO - "pgo_build": "True", 02:07:09 INFO - "basedir": "/builds/slave/test", 02:07:09 INFO - "buildnumber": 135, 02:07:09 INFO - "slavename": "talos-linux64-ix-028", 02:07:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:07:09 INFO - "platform": "ubuntu64_hw", 02:07:09 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:07:09 INFO - "branch": "mozilla-beta", 02:07:09 INFO - "repo_path": "releases/mozilla-beta", 02:07:09 INFO - "revision": "1f9f6bdee31c14fd5a39485e8ae326de2928ef7d", 02:07:09 INFO - "stage_platform": "linux64-pgo", 02:07:09 INFO - "builduid": "3d31ab4f42854c829e06ac6160cc676b", 02:07:09 INFO - "slavebuilddir": "test" 02:07:09 INFO - } 02:07:09 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:07:09 INFO - Running post-action listener: _resource_record_post_action 02:07:09 INFO - ##### 02:07:09 INFO - ##### Running download-and-extract step. 02:07:09 INFO - ##### 02:07:09 INFO - Running pre-action listener: _resource_record_pre_action 02:07:09 INFO - Running main action method: download_and_extract 02:07:09 INFO - mkdir: /builds/slave/test/build/tests 02:07: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:07:09 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:07:09 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:07:09 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:07:09 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:07:09 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:07:10 INFO - Downloaded 1327 bytes. 02:07:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:07:10 INFO - Using the following test package requirements: 02:07:10 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:07:10 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:07:10 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 02:07:10 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'jsshell-linux-x86_64.zip'], 02:07:10 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:07:10 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:07:10 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 02:07:10 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 02:07:10 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:07:10 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:10 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:07:10 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:07:10 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:07:10 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:07:10 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:07:10 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:07:10 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:07:10 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:07:11 INFO - Downloaded 24176679 bytes. 02:07:11 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:07:11 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:07:12 INFO - Return code: 0 02:07:12 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:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:12 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:07:12 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:07:12 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:07:12 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:07:12 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:07:15 INFO - Downloaded 24176679 bytes. 02:07:15 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:07:15 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:07:16 INFO - Return code: 0 02:07: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:07:16 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:07:16 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:07:16 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:07:16 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:07:16 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:07:17 INFO - Downloaded 10840145 bytes. 02:07:17 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:07:17 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:07:17 INFO - Return code: 0 02:07:18 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:07:18 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:07:18 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:07:18 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:07:18 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:07:18 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:07:19 INFO - Downloaded 55996763 bytes. 02:07:19 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:07:19 INFO - mkdir: /builds/slave/test/properties 02:07:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:19 INFO - Contents: 02:07:19 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:07:20 INFO - Running post-action listener: _resource_record_post_action 02:07:20 INFO - Running post-action listener: set_extra_try_arguments 02:07:20 INFO - ##### 02:07:20 INFO - ##### Running populate-webroot step. 02:07:20 INFO - ##### 02:07:20 INFO - Running pre-action listener: _resource_record_pre_action 02:07:20 INFO - Running main action method: populate_webroot 02:07:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:20 INFO - '--tppagecycles', 02:07:20 INFO - '7'], 02:07:20 INFO - 'tests': ['tsvgm']}}, 02:07:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['damp', 'tps']}, 02:07:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'tests': ['damp', 'tps']}, 02:07:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['dromaeo_dom']}, 02:07:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['a11yr', 02:07:20 INFO - 'ts_paint', 02:07:20 INFO - 'tpaint', 02:07:20 INFO - 'sessionrestore', 02:07:20 INFO - 'sessionrestore_no_auto_restore', 02:07:20 INFO - 'tabpaint']}, 02:07:20 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:20 INFO - 'ts_paint', 02:07:20 INFO - 'tpaint', 02:07:20 INFO - 'sessionrestore', 02:07:20 INFO - 'sessionrestore_no_auto_restore', 02:07:20 INFO - 'tabpaint']}, 02:07:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:20 INFO - 'ts_paint', 02:07:20 INFO - 'tpaint', 02:07:20 INFO - 'sessionrestore', 02:07:20 INFO - 'sessionrestore_no_auto_restore', 02:07:20 INFO - 'tabpaint']}, 02:07:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:20 INFO - 'ts_paint', 02:07:20 INFO - 'tpaint', 02:07:20 INFO - 'sessionrestore', 02:07:20 INFO - 'sessionrestore_no_auto_restore', 02:07:20 INFO - 'tabpaint']}, 02:07:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['a11yr', 02:07:20 INFO - 'ts_paint', 02:07:20 INFO - 'tpaint', 02:07:20 INFO - 'sessionrestore', 02:07:20 INFO - 'sessionrestore_no_auto_restore', 02:07:20 INFO - 'tabpaint']}, 02:07:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['a11yr', 02:07:20 INFO - 'ts_paint', 02:07:20 INFO - 'tpaint', 02:07:20 INFO - 'sessionrestore', 02:07:20 INFO - 'sessionrestore_no_auto_restore', 02:07:20 INFO - 'tabpaint']}, 02:07:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['tsvgx', 02:07:20 INFO - 'tsvgr_opacity', 02:07:20 INFO - 'tart', 02:07:20 INFO - 'tscrollx', 02:07:20 INFO - 'cart']}, 02:07:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:20 INFO - 'tsvgr_opacity', 02:07:20 INFO - 'tart', 02:07:20 INFO - 'tscrollx', 02:07:20 INFO - 'cart']}, 02:07:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'talos_options': ['--disable-e10s'], 02:07:20 INFO - 'tests': ['tp5o']}, 02:07:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'tests': ['tp5o']}, 02:07:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'talos_options': ['--disable-e10s', 02:07:20 INFO - '--xperf_path', 02:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:20 INFO - 'tests': ['tp5n']}, 02:07:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:20 INFO - 'talos_options': ['--xperf_path', 02:07:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:20 INFO - 'tests': ['tp5n']}}, 02:07:20 INFO - 'talos.zip': {'path': '', 02:07:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:20 INFO - Running post-action listener: _resource_record_post_action 02:07:20 INFO - ##### 02:07:20 INFO - ##### Running create-virtualenv step. 02:07:20 INFO - ##### 02:07:20 INFO - Running pre-action listener: _resource_record_pre_action 02:07:20 INFO - Running main action method: create_virtualenv 02:07:20 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:20 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:07:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:20 INFO - Using real prefix '/usr' 02:07:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:20 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:22 INFO - Installing pip.................done. 02:07:22 INFO - Return code: 0 02:07:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:22 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:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:22 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:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:22 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:22 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:07:22 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:07:22 INFO - Using env: {'DISPLAY': ':0', 02:07:22 INFO - 'HOME': '/home/cltbld', 02:07:22 INFO - 'LANG': 'en_US.UTF-8', 02:07:22 INFO - 'LANGUAGE': 'en_US:en', 02:07:22 INFO - 'LOGNAME': 'cltbld', 02:07:22 INFO - 'MAIL': '/var/mail/cltbld', 02:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:22 INFO - 'MOZ_NO_REMOTE': '1', 02:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:22 INFO - 'NO_EM_RESTART': '1', 02:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:22 INFO - 'PWD': '/builds/slave/test', 02:07:22 INFO - 'SHELL': '/bin/bash', 02:07:22 INFO - 'SHLVL': '1', 02:07:22 INFO - 'TERM': 'linux', 02:07:22 INFO - 'TMOUT': '86400', 02:07:22 INFO - 'USER': 'cltbld', 02:07:22 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:22 INFO - '_': '/tools/buildbot/bin/python'} 02:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:23 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:07:23 INFO - Cleaning up... 02:07:23 INFO - Return code: 0 02:07:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:07:23 INFO - Using env: {'DISPLAY': ':0', 02:07:23 INFO - 'HOME': '/home/cltbld', 02:07:23 INFO - 'LANG': 'en_US.UTF-8', 02:07:23 INFO - 'LANGUAGE': 'en_US:en', 02:07:23 INFO - 'LOGNAME': 'cltbld', 02:07:23 INFO - 'MAIL': '/var/mail/cltbld', 02:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:23 INFO - 'MOZ_NO_REMOTE': '1', 02:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:23 INFO - 'NO_EM_RESTART': '1', 02:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:23 INFO - 'PWD': '/builds/slave/test', 02:07:23 INFO - 'SHELL': '/bin/bash', 02:07:23 INFO - 'SHLVL': '1', 02:07:23 INFO - 'TERM': 'linux', 02:07:23 INFO - 'TMOUT': '86400', 02:07:23 INFO - 'USER': 'cltbld', 02:07:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:23 INFO - '_': '/tools/buildbot/bin/python'} 02:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:23 INFO - Downloading/unpacking psutil>=0.7.1 02:07:23 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:07:23 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:07:23 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:07:23 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:07:23 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:07:23 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:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:25 INFO - Installing collected packages: psutil 02:07:25 INFO - Running setup.py install for psutil 02:07:25 INFO - building 'psutil._psutil_linux' extension 02:07:25 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:07:25 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:07:25 INFO - building 'psutil._psutil_posix' extension 02:07:25 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:07:25 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:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:25 INFO - Successfully installed psutil 02:07:25 INFO - Cleaning up... 02:07:25 INFO - Return code: 0 02:07:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:07:25 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:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:25 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:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:25 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:25 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:07:25 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:07:25 INFO - Using env: {'DISPLAY': ':0', 02:07:25 INFO - 'HOME': '/home/cltbld', 02:07:25 INFO - 'LANG': 'en_US.UTF-8', 02:07:25 INFO - 'LANGUAGE': 'en_US:en', 02:07:25 INFO - 'LOGNAME': 'cltbld', 02:07:25 INFO - 'MAIL': '/var/mail/cltbld', 02:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:25 INFO - 'MOZ_NO_REMOTE': '1', 02:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:25 INFO - 'NO_EM_RESTART': '1', 02:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:25 INFO - 'PWD': '/builds/slave/test', 02:07:25 INFO - 'SHELL': '/bin/bash', 02:07:25 INFO - 'SHLVL': '1', 02:07:25 INFO - 'TERM': 'linux', 02:07:25 INFO - 'TMOUT': '86400', 02:07:25 INFO - 'USER': 'cltbld', 02:07:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:25 INFO - '_': '/tools/buildbot/bin/python'} 02:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:07:26 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:07:26 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:07:26 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:07:26 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:07:26 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:07:26 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:07:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:27 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:07:27 INFO - Installing collected packages: mozsystemmonitor 02:07:27 INFO - Running setup.py install for mozsystemmonitor 02:07:28 INFO - Successfully installed mozsystemmonitor 02:07:28 INFO - Cleaning up... 02:07:28 INFO - Return code: 0 02:07:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07:28 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:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:28 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:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:28 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:28 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:07:28 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:07:28 INFO - Using env: {'DISPLAY': ':0', 02:07:28 INFO - 'HOME': '/home/cltbld', 02:07:28 INFO - 'LANG': 'en_US.UTF-8', 02:07:28 INFO - 'LANGUAGE': 'en_US:en', 02:07:28 INFO - 'LOGNAME': 'cltbld', 02:07:28 INFO - 'MAIL': '/var/mail/cltbld', 02:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:28 INFO - 'MOZ_NO_REMOTE': '1', 02:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:28 INFO - 'NO_EM_RESTART': '1', 02:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:28 INFO - 'PWD': '/builds/slave/test', 02:07:28 INFO - 'SHELL': '/bin/bash', 02:07:28 INFO - 'SHLVL': '1', 02:07:28 INFO - 'TERM': 'linux', 02:07:28 INFO - 'TMOUT': '86400', 02:07:28 INFO - 'USER': 'cltbld', 02:07:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:28 INFO - '_': '/tools/buildbot/bin/python'} 02:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:07:28 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:07:28 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:07:28 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:07:28 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:07:28 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:07:28 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:07:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:30 INFO - Downloading docopt-0.6.1.tar.gz 02:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:31 INFO - Running setup.py install for blobuploader 02:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:31 INFO - Running setup.py install for requests 02:07:31 INFO - Running setup.py install for docopt 02:07:31 INFO - Successfully installed blobuploader requests docopt 02:07:31 INFO - Cleaning up... 02:07:31 INFO - Return code: 0 02:07:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:31 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:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:31 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:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:31 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:31 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:07:31 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:07:31 INFO - Using env: {'DISPLAY': ':0', 02:07:31 INFO - 'HOME': '/home/cltbld', 02:07:31 INFO - 'LANG': 'en_US.UTF-8', 02:07:31 INFO - 'LANGUAGE': 'en_US:en', 02:07:31 INFO - 'LOGNAME': 'cltbld', 02:07:31 INFO - 'MAIL': '/var/mail/cltbld', 02:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:31 INFO - 'MOZ_NO_REMOTE': '1', 02:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:31 INFO - 'NO_EM_RESTART': '1', 02:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:31 INFO - 'PWD': '/builds/slave/test', 02:07:31 INFO - 'SHELL': '/bin/bash', 02:07:31 INFO - 'SHLVL': '1', 02:07:31 INFO - 'TERM': 'linux', 02:07:31 INFO - 'TMOUT': '86400', 02:07:31 INFO - 'USER': 'cltbld', 02:07:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:31 INFO - '_': '/tools/buildbot/bin/python'} 02:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:31 INFO - Running setup.py (path:/tmp/pip-77gRnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:31 INFO - Running setup.py (path:/tmp/pip-dHM1fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:31 INFO - Running setup.py (path:/tmp/pip-2XNwQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:32 INFO - Running setup.py (path:/tmp/pip-qisNGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:32 INFO - Running setup.py (path:/tmp/pip-32KTtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:32 INFO - Running setup.py (path:/tmp/pip-H_UPus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:32 INFO - Running setup.py (path:/tmp/pip-l5xBly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:32 INFO - Running setup.py (path:/tmp/pip-fFnysK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:32 INFO - Running setup.py (path:/tmp/pip-T4NtrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:32 INFO - Running setup.py (path:/tmp/pip-ZW90aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:32 INFO - Running setup.py (path:/tmp/pip-XQ7kz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:32 INFO - Running setup.py (path:/tmp/pip-CIVkNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:32 INFO - Running setup.py (path:/tmp/pip-mFWFrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:32 INFO - Running setup.py (path:/tmp/pip-Cg_gg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:32 INFO - Running setup.py (path:/tmp/pip-zUc6_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:32 INFO - Running setup.py (path:/tmp/pip-ed4btC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:32 INFO - Running setup.py (path:/tmp/pip-5YaMHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:33 INFO - Running setup.py install for manifestparser 02:07:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Running setup.py install for mozcrash 02:07:33 INFO - Running setup.py install for mozdebug 02:07:33 INFO - Running setup.py install for mozdevice 02:07:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Running setup.py install for mozfile 02:07:33 INFO - Running setup.py install for mozhttpd 02:07:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Running setup.py install for mozinfo 02:07:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Running setup.py install for mozInstall 02:07:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Running setup.py install for mozleak 02:07:33 INFO - Running setup.py install for mozlog 02:07:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:34 INFO - Running setup.py install for moznetwork 02:07:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:34 INFO - Running setup.py install for mozprocess 02:07:34 INFO - Running setup.py install for mozprofile 02:07:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:34 INFO - Running setup.py install for mozrunner 02:07:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:34 INFO - Running setup.py install for mozscreenshot 02:07:34 INFO - Running setup.py install for moztest 02:07:34 INFO - Running setup.py install for mozversion 02:07:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:34 INFO - Cleaning up... 02:07:34 INFO - Return code: 0 02:07:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:34 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:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:34 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:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:34 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:34 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:07:34 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:07:34 INFO - Using env: {'DISPLAY': ':0', 02:07:34 INFO - 'HOME': '/home/cltbld', 02:07:34 INFO - 'LANG': 'en_US.UTF-8', 02:07:34 INFO - 'LANGUAGE': 'en_US:en', 02:07:34 INFO - 'LOGNAME': 'cltbld', 02:07:34 INFO - 'MAIL': '/var/mail/cltbld', 02:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:34 INFO - 'MOZ_NO_REMOTE': '1', 02:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:34 INFO - 'NO_EM_RESTART': '1', 02:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:34 INFO - 'PWD': '/builds/slave/test', 02:07:34 INFO - 'SHELL': '/bin/bash', 02:07:34 INFO - 'SHLVL': '1', 02:07:34 INFO - 'TERM': 'linux', 02:07:34 INFO - 'TMOUT': '86400', 02:07:34 INFO - 'USER': 'cltbld', 02:07:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:34 INFO - '_': '/tools/buildbot/bin/python'} 02:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:35 INFO - Running setup.py (path:/tmp/pip-MLVVsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:35 INFO - Running setup.py (path:/tmp/pip-e7eFIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:35 INFO - Running setup.py (path:/tmp/pip-7Orw5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:35 INFO - Running setup.py (path:/tmp/pip-RS9FXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:35 INFO - Running setup.py (path:/tmp/pip-w5lMZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:35 INFO - Running setup.py (path:/tmp/pip-lc1HUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:35 INFO - Running setup.py (path:/tmp/pip-ww5FeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:35 INFO - Running setup.py (path:/tmp/pip-2yLJ4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:35 INFO - Running setup.py (path:/tmp/pip-dX6qXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:35 INFO - Running setup.py (path:/tmp/pip-uihWyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:35 INFO - Running setup.py (path:/tmp/pip-pQu46D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:35 INFO - Running setup.py (path:/tmp/pip-E8LwJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:35 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:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:35 INFO - Running setup.py (path:/tmp/pip-Lb56R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:36 INFO - Running setup.py (path:/tmp/pip-7ZXYs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:36 INFO - Running setup.py (path:/tmp/pip-6LaoCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:36 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:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:36 INFO - Running setup.py (path:/tmp/pip-bLThRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:36 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:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:36 INFO - Running setup.py (path:/tmp/pip-aAswcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:36 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:07:36 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:07:36 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:07:36 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:07:36 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:07:36 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:07:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:36 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:07:36 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:07:36 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:07:36 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:07:36 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:07:36 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:07:38 INFO - Downloading blessings-1.6.tar.gz 02:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:38 INFO - Installing collected packages: blessings 02:07:38 INFO - Running setup.py install for blessings 02:07:38 INFO - Successfully installed blessings 02:07:38 INFO - Cleaning up... 02:07:38 INFO - Return code: 0 02:07:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:38 INFO - Reading from file tmpfile_stdout 02:07:38 INFO - Current package versions: 02:07:38 INFO - argparse == 1.2.1 02:07:38 INFO - blessings == 1.6 02:07:38 INFO - blobuploader == 1.2.4 02:07:38 INFO - docopt == 0.6.1 02:07:38 INFO - manifestparser == 1.1 02:07:38 INFO - mozInstall == 1.12 02:07:38 INFO - mozcrash == 0.17 02:07:38 INFO - mozdebug == 0.1 02:07:38 INFO - mozdevice == 0.48 02:07:38 INFO - mozfile == 1.2 02:07:38 INFO - mozhttpd == 0.7 02:07:38 INFO - mozinfo == 0.9 02:07:38 INFO - mozleak == 0.1 02:07:38 INFO - mozlog == 3.1 02:07:38 INFO - moznetwork == 0.27 02:07:38 INFO - mozprocess == 0.22 02:07:38 INFO - mozprofile == 0.28 02:07:38 INFO - mozrunner == 6.11 02:07:38 INFO - mozscreenshot == 0.1 02:07:38 INFO - mozsystemmonitor == 0.0 02:07:38 INFO - moztest == 0.7 02:07:38 INFO - mozversion == 1.4 02:07:38 INFO - psutil == 3.1.1 02:07:38 INFO - requests == 1.2.3 02:07:38 INFO - wsgiref == 0.1.2 02:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:38 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:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:38 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:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:38 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:38 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:07:38 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:07:38 INFO - Using env: {'DISPLAY': ':0', 02:07:38 INFO - 'HOME': '/home/cltbld', 02:07:38 INFO - 'LANG': 'en_US.UTF-8', 02:07:38 INFO - 'LANGUAGE': 'en_US:en', 02:07:38 INFO - 'LOGNAME': 'cltbld', 02:07:38 INFO - 'MAIL': '/var/mail/cltbld', 02:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:38 INFO - 'MOZ_NO_REMOTE': '1', 02:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:38 INFO - 'NO_EM_RESTART': '1', 02:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:38 INFO - 'PWD': '/builds/slave/test', 02:07:38 INFO - 'SHELL': '/bin/bash', 02:07:38 INFO - 'SHLVL': '1', 02:07:38 INFO - 'TERM': 'linux', 02:07:38 INFO - 'TMOUT': '86400', 02:07:38 INFO - 'USER': 'cltbld', 02:07:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:38 INFO - '_': '/tools/buildbot/bin/python'} 02:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 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:07:38 INFO - Cleaning up... 02:07:38 INFO - Return code: 0 02:07:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:38 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:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:38 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:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:38 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:38 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:07:38 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:07:38 INFO - Using env: {'DISPLAY': ':0', 02:07:38 INFO - 'HOME': '/home/cltbld', 02:07:38 INFO - 'LANG': 'en_US.UTF-8', 02:07:38 INFO - 'LANGUAGE': 'en_US:en', 02:07:38 INFO - 'LOGNAME': 'cltbld', 02:07:38 INFO - 'MAIL': '/var/mail/cltbld', 02:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:38 INFO - 'MOZ_NO_REMOTE': '1', 02:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:38 INFO - 'NO_EM_RESTART': '1', 02:07:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:38 INFO - 'PWD': '/builds/slave/test', 02:07:38 INFO - 'SHELL': '/bin/bash', 02:07:38 INFO - 'SHLVL': '1', 02:07:38 INFO - 'TERM': 'linux', 02:07:38 INFO - 'TMOUT': '86400', 02:07:38 INFO - 'USER': 'cltbld', 02:07:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:38 INFO - '_': '/tools/buildbot/bin/python'} 02:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:39 INFO - Downloading/unpacking jsonschema 02:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:40 INFO - Downloading/unpacking functools32 (from jsonschema) 02:07:40 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:07:40 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:07:40 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:07:40 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:07:40 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:07:40 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:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:41 INFO - warning: no files found matching '*.txt' 02:07:41 INFO - no previously-included directories found matching 'build' 02:07:41 INFO - no previously-included directories found matching 'dist' 02:07:41 INFO - no previously-included directories found matching '.git*' 02:07:41 INFO - Installing collected packages: jsonschema, functools32 02:07:41 INFO - Running setup.py install for functools32 02:07:41 INFO - warning: no files found matching '*.txt' 02:07:41 INFO - no previously-included directories found matching 'build' 02:07:41 INFO - no previously-included directories found matching 'dist' 02:07:41 INFO - no previously-included directories found matching '.git*' 02:07:41 INFO - Successfully installed jsonschema functools32 02:07:41 INFO - Cleaning up... 02:07:41 INFO - Return code: 0 02:07:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:41 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 0x7f1460078f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16215a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, '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': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', '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:07:41 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:07:41 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:07:41 INFO - Using env: {'DISPLAY': ':0', 02:07:41 INFO - 'HOME': '/home/cltbld', 02:07:41 INFO - 'LANG': 'en_US.UTF-8', 02:07:41 INFO - 'LANGUAGE': 'en_US:en', 02:07:41 INFO - 'LOGNAME': 'cltbld', 02:07:41 INFO - 'MAIL': '/var/mail/cltbld', 02:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:41 INFO - 'MOZ_NO_REMOTE': '1', 02:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:41 INFO - 'NO_EM_RESTART': '1', 02:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:41 INFO - 'PWD': '/builds/slave/test', 02:07:41 INFO - 'SHELL': '/bin/bash', 02:07:41 INFO - 'SHLVL': '1', 02:07:41 INFO - 'TERM': 'linux', 02:07:41 INFO - 'TMOUT': '86400', 02:07:41 INFO - 'USER': 'cltbld', 02:07:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:41 INFO - '_': '/tools/buildbot/bin/python'} 02:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:41 INFO - Downloading/unpacking flake8 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:07:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:07:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:07:45 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:07:45 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:07:45 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:07:45 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:07:45 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:07:45 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:07:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:07:45 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:07:45 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:07:45 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:07:45 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:07:45 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:07:45 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:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:45 INFO - no previously-included directories found matching 'docs/_build' 02:07:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:07:45 INFO - Running setup.py install for pep8 02:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:45 INFO - no previously-included directories found matching 'docs/_build' 02:07:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:07:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:07:45 INFO - Cleaning up... 02:07:45 INFO - Return code: 0 02:07:45 INFO - Running post-action listener: _resource_record_post_action 02:07:45 INFO - Running post-action listener: _start_resource_monitoring 02:07:45 INFO - Starting resource monitoring. 02:07:45 INFO - ##### 02:07:45 INFO - ##### Running install step. 02:07:45 INFO - ##### 02:07:45 INFO - Running pre-action listener: _resource_record_pre_action 02:07:45 INFO - Running main action method: install 02:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:46 INFO - Reading from file tmpfile_stdout 02:07:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:46 INFO - Reading from file tmpfile_stdout 02:07:46 INFO - Output received: 02:07:46 INFO - Usage: mozinstall [options] installer 02:07:46 INFO - Options: 02:07:46 INFO - -h, --help show this help message and exit 02:07:46 INFO - -d DEST, --destination=DEST 02:07:46 INFO - Directory to install application into. [default: 02:07:46 INFO - "/builds/slave/test"] 02:07:46 INFO - --app=APP Application being installed. [default: firefox] 02:07:46 INFO - mkdir: /builds/slave/test/build/application 02:07:46 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:07:46 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:07:59 INFO - Reading from file tmpfile_stdout 02:07:59 INFO - Output received: 02:07:59 INFO - /builds/slave/test/build/application/firefox/firefox 02:07:59 INFO - Running post-action listener: _resource_record_post_action 02:07:59 INFO - ##### 02:07:59 INFO - ##### Running run-tests step. 02:07:59 INFO - ##### 02:07:59 INFO - Running pre-action listener: _resource_record_pre_action 02:07:59 INFO - Running main action method: run_tests 02:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:59 INFO - Python 2.7.3 02:07:59 INFO - Return code: 0 02:07:59 INFO - grabbing minidump binary from tooltool 02:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:59 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 0x16b0410>, '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 0x16b1310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b17a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:59 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:07:59 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:07:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:59 INFO - Return code: 0 02:07:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:07:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:07:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:08:00 INFO - Return code: 0 02:08:00 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-028', '--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:08:00 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-028 --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:08:00 INFO - Using env: {'DISPLAY': ':0', 02:08:00 INFO - 'HOME': '/home/cltbld', 02:08:00 INFO - 'LANG': 'en_US.UTF-8', 02:08:00 INFO - 'LANGUAGE': 'en_US:en', 02:08:00 INFO - 'LOGNAME': 'cltbld', 02:08:00 INFO - 'MAIL': '/var/mail/cltbld', 02:08:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:00 INFO - 'MOZ_NO_REMOTE': '1', 02:08:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:00 INFO - 'NO_EM_RESTART': '1', 02:08:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:00 INFO - 'PWD': '/builds/slave/test', 02:08:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:00 INFO - 'SHELL': '/bin/bash', 02:08:00 INFO - 'SHLVL': '1', 02:08:00 INFO - 'TERM': 'linux', 02:08:00 INFO - 'TMOUT': '86400', 02:08:00 INFO - 'USER': 'cltbld', 02:08:00 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990', 02:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:00 INFO - '_': '/tools/buildbot/bin/python'} 02:08:00 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-028', '--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:08:00 INFO - mozversion application_buildid: 20160606194329 02:08:00 INFO - mozversion application_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:08:00 INFO - mozversion application_display_name: Firefox 02:08:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:00 INFO - mozversion application_name: Firefox 02:08:00 INFO - mozversion application_remotingname: firefox 02:08:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:00 INFO - mozversion application_vendor: Mozilla 02:08:00 INFO - mozversion application_version: 48.0 02:08:00 INFO - mozversion platform_buildid: 20160606194329 02:08:00 INFO - mozversion platform_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:08:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:00 INFO - mozversion platform_version: 48.0 02:08:00 INFO - using testdate: 1465290480 02:08:00 INFO - actual date: 1465290480 02:08:00 INFO - starting webserver on 'localhost:51479' 02:08:00 INFO - SUITE-START | Running 2 tests 02:08:00 INFO - TEST-START | dromaeo_css 02:08:00 INFO - operating with platform_type : linux_ 02:08:00 INFO - Initialising browser for dromaeo_css test... 02:08:00 INFO - TEST-INFO | started process 7766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJhJu3s/profile http://localhost:51479/getInfo.html) 02:08:04 INFO - PROCESS | 7766 | 02:08:04 INFO - PROCESS | 7766 | (process:7845): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:08:05 INFO - PROCESS | 7766 | __metrics Screen width/height:1600/1200 02:08:05 INFO - PROCESS | 7766 | colorDepth:24 02:08:05 INFO - PROCESS | 7766 | Browser inner width/height: 1024/697 02:08:05 INFO - PROCESS | 7766 | __metrics 02:08:05 ERROR - PROCESS | 7766 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:08:06 INFO - TEST-INFO | 7766: exit 0 02:08:06 INFO - Browser initialized. 02:08:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:06 INFO - TEST-INFO | started process 7895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJhJu3s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:08 INFO - PROCESS | 7895 | 02:08:08 INFO - PROCESS | 7895 | (process:7963): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:08:18 INFO - PROCESS | 7895 | RSS: Main: 151171072 02:08:18 INFO - PROCESS | 7895 | 02:09:08 INFO - PROCESS | 7895 | 1465290548106 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:11:15 INFO - PROCESS | 7895 | Cycle 1(1): loaded http://localhost:51479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51479/tests/dromaeo/cssquery-ext.html) 02:11:16 INFO - PROCESS | 7895 | RSS: Main: 156196864 02:11:16 INFO - PROCESS | 7895 | 02:14:18 INFO - PROCESS | 7895 | Cycle 1(1): loaded http://localhost:51479/tests/dromaeo/cssquery-ext.html (next: http://localhost:51479/tests/dromaeo/cssquery-jquery.html) 02:14:19 INFO - PROCESS | 7895 | RSS: Main: 152920064 02:14:19 INFO - PROCESS | 7895 | 02:17:20 INFO - PROCESS | 7895 | Cycle 1(1): loaded http://localhost:51479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51479/tests/dromaeo/cssquery-mootools.html) 02:17:21 INFO - PROCESS | 7895 | RSS: Main: 152657920 02:17:21 INFO - PROCESS | 7895 | 02:20:23 INFO - PROCESS | 7895 | Cycle 1(1): loaded http://localhost:51479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51479/tests/dromaeo/cssquery-prototype.html) 02:20:23 INFO - PROCESS | 7895 | RSS: Main: 153620480 02:20:23 INFO - PROCESS | 7895 | 02:23:25 INFO - PROCESS | 7895 | Cycle 1(1): loaded http://localhost:51479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51479/tests/dromaeo/cssquery-yui.html) 02:23:26 INFO - PROCESS | 7895 | RSS: Main: 152567808 02:23:26 INFO - PROCESS | 7895 | 02:26:28 INFO - PROCESS | 7895 | Cycle 1(1): loaded http://localhost:51479/tests/dromaeo/cssquery-yui.html (next: http://localhost:51479/tests/dromaeo/cssquery-dojo.html) 02:26:29 INFO - PROCESS | 7895 | RSS: Main: 156618752 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | __start_tp_report 02:26:29 INFO - PROCESS | 7895 | _x_x_mozilla_page_load 02:26:29 INFO - PROCESS | 7895 | _x_x_mozilla_page_load_details 02:26:29 INFO - PROCESS | 7895 | |i|pagename|runs| 02:26:29 INFO - PROCESS | 7895 | |0;dojo.html;3317.850696718647;3371.6796904294083;3383.069655844643;3412.6246112927556;3417.29945361201;5686.31764188298;5716.828495145152;5723.914141287884;5756.798512052073;5771.394003629616;5689.743961521731;5693.459121383462;5700.1449782532645;5723.370429252779;5731.598788084836;5145.3053837731895;5175.404828444721;5244.79020839166;5284.735763211824;5293.311869456985;5103.362079740033;5179;5391.81128660497;5393.029254734146;5400.270963419927;5299.814506492274;5326.973365133169;5348.572114230852;5361.08861493547;5371.731413429333;5238.842834714946;5264.8157314494;5273.4462881397285;5277.287566178594;5299.655522391032;5060.9493905060845;5103.4896510349035;5137.460566640524;5159.896802063938;5171.974140129313;5410.1343784994215;5416.674999500043;5450.890982180374;5470.7264636768;5513.145462453286;5953.910691339634;5980.162777211194;5981.58128930975;5983;5998.880022399571;5943.970280148572;5982.012967860298;6001.819945401645;6039.063945088518;6050.727717252734;5642.125470552071;5669.036263835158;5686.459786320334;5698.971505142489;5707;6209.96895015522;6232.189815323979;6236.656983865841;6236.844078897973;6276.121343011982;6023.969880150659;6070.3019152798;6090.390960903874;6117.388261173936;6128.540359473057;6013.308469525973;6030.758769649253;6037.154798328237;6040.818775436744;6043.425874541911;5906.379830117776;5964.075568286922;5985.910211346746;5999.730012149464;6008.549358798107;6102;6129.817282374534;6130.826205142326;6142.477889379364;6155.230596175478;4631.189541830234;4638.976805115953;4642.744649044267;4663;4674.462436819741;4074.2462644410284;4097.528784189856;4119.629233369011;4155.314373128461;4176;5797.536197104306;5816.534677225812;5851.941480585139;5860.736266868002;5942.3166335871065;5962.403759624003;6046.516278697693;6065.75736970525;6067.605605635619;6081.148639190517;5838.153467747153;5843.474087332161;5853.824385268449;5909.586328957018;5913.674747888821;5121.257417674491;5134.435212126663;5174.922376164361;5184.507471790174;5196.948030519647;6240.5319601030105;6263.655498947511;6278.4035516625845;6298.149749783812;6317.178766760384;5921.496672782861;6066.423689749467;6090.23872015998;6092.238470191226;6093.177421048102;6370.299267080525;6394.680265986775;6420.6789660517725;6425.485961123192;6427;6130.172426722335;6132.018876979661;6132.2947860996555;6133.141360209485;6136.478399336106;5950.9702451487465;6059.72731227087;6135.049067394561;6222.595531290452;6233.345498722569;5827.679477628772;5844.912326315194;5877.764889404376;5884.705764711662;5929.377415371324;5835.153902684172;5841.707914604168;5844.970775146097;5851.502622276984;5879.94120058811;5758.712064396847;5782.855428614318;5794.2177805997335;5867.647941123546;5890.263717035371;5890.2342695449315;5907.202527658711;5939.16851640762;5944.851378715567;5964.105384192232;5754.6547207167705;5759.481646651821;5775.6823374714795;5775.884482310246;5779.162021506774 02:26:29 INFO - PROCESS | 7895 | |1;ext.html;670.7752902777569;680.5780416141992;689.4139981016134;733.3619750816787;747.4543583184277;32790.836045819764;33778.66221337786;39408.2118357633;39983.200335993264;40252.19495610086;41947;42721.786391068;42780.35829462553;42838.57161428385;42864.14271714564;8670.783230419227;8866.202041816236;8879.28965682744;8899.243564297043;8909.242714369286;8719.738407847743;8819.911800882006;8851.070637583058;8858.468491890475;8870.467771933672;9029.95485022574;9146.77133071672;9151.496667683276;9169.08309169081;9187.402818816789;9075.909240907606;9130;9132.726018219431;9156.816863662689;9159.908400915972;8971.013188549254;9042.457452552802;9080.500572468512;9083.182513573744;9095.772605684844;43626;43857.56142438567;43897.561024389666;43957.78021109874;43979.78010109961;3766.642168993941;3792.2984247914223;3810.5046343975105;3857.691384689218;4214.599613036757;32973.34053318944;33029.66970330314;33196;33232;34556.654433455595;4456.977715111436;4498.235299999008;4525.185466616041;4526.434195725535;4556.681032327739;230821;231024;231434;232555;232645;56527.71736141293;56704.71647641818;57199.42800572024;57341;57445.42554574401;69214;71002.64498677473;71151.64424177846;71235.64382178056;71242.64378678177;17404.82595174032;17529.474115776546;17564.560885977953;17587.384441544484;17603.55991100233;13359.465621375231;13369.46522139123;13370.39833207508;13439.193648381128;13478.595642130751;19977.500562485762;20105;20262.69605955912;20285.188592456136;20956.89521552413;7538.3215510604305;7580.853945612509;7625;7757.7672669819995;7762.456628035983;1165.568739566349;1183.3668987092037;1187.1037366788191;1189.3518032672214;1191.9940400298117;32332;32840.50739238913;32976.17559560982;33006.3398732024;34061.65938340585;1202.446874437751;1205.572021932219;1210.5460452330376;1236.208826351136;1242.2174478712343;17172.656546869242;17248.396306129227;17302.91348543249;17308.394206202724;17365.479035628698;554382;622606;637826;648301;969263;57593.424065759646;58909;58970;58978.70510647505;59023;1494.880409567232;1509.2227502835829;1512.4857548433586;1520.8935374523678;1644.8272931342276;29936.70063299339;30763.384732305676;31058.996771321188;31523.52714709327;31881.8405907969;52521;52646.473535265686;53072;53093.4690653104;53129.734351328;453510;457507;461533;462087;463335;29043.273918152216;29339.559906600993;31196.844015779774;31258.68741312649;31279.218019549695;47930.76034619805;48812.40378271405;48954.26568601403;49453.75273123611;49824.25263620976;41218;41704.58295417007;42207.155856883306;42844.57155428531;43469;41691;41966.370504441846;42229.78885105555;42282.36576451417;42454.78772606241;41791;42070.15859682851;42373.78813105915;42910.35634465423;42989;35984;36223.63776362203;36519.45220821743;36798.44802328021;36899;28239.576406354332;28481.145565633065;28682.56976145318;29083.41833163367;29138.27154321159 02:26:29 INFO - PROCESS | 7895 | |2;jquery.html;404.2763453418381;407.0982773157456;410.8644147431348;415.1385874310805;415.17885964868714;18455.26178952842;19109.235630574778;19132.90433547834;19160.904195479037;21250.46873828155;20485.385438436835;20514.589708205865;20531.178752849904;20727.792722072776;20732;5763.423657634224;5971.731272092767;5981.28224613047;7277.9636101819415;7629.160792312841;7512;7516.887246691304;7542.358899493523;7543.886841697379;7567.848643027136;7326.4871458997895;7696.961515192416;7718.228177182293;7721.922780772176;7729.420293477983;7035.296470352975;7343.5961022143765;7632;7693.999780028588;7695.0765908090825;7084.291570842926;7129.108861392326;7141.500094993353;7174.892376614355;7176.712931482734;25361.873190634113;26382.73617263822;26760.46479070427;27443.31391715203;27546.311342216406;3123.859426325821;3413.812240326781;3450.396180668373;3528.770629909048;3562.1806984393475;15849.207539622972;16057.91971040149;16148;16461.506154815375;16912.915435422743;1989.333573252962;2180.967285490719;2207.4572497726404;2293.9541209175723;2352.952940941189;94277.52861235719;95347;97978;99125.50437247768;99541.00458995462;17740.379086731904;19219.80780192208;19892.70160947587;20473.590528189354;20514.38456846297;33512.664873351445;33672;33803.32393352119;34142.14644633854;34236.82881585626;7575.848483030309;7899.565523896241;7993.200679932076;8118.594070296462;8198.877016844752;7904.525728456311;8073.717419890393;8087.83824323522;8105.75682729519;8370.372222083368;4723.881902952385;4726.85819425411;4747.098051370298;4786.64100192487;4839.2983017462975;1971.6549603819274;1986.2948653228184;1986.9006549672458;1997.5805080933167;2052.7023581580884;874.510274246424;1000.0499525450706;1037.5642230263309;1057.3602970202917;1104.1829046505527;18583.34958276454;18698.43904682862;19452.51368715765;19484.61030779405;19739.802601973795;1115.358668765463;1119.7200699825044;1121.2879821313525;1144.9427528623535;1168.3340495917246;10788.8573279513;10916.126709863192;11008.669739907815;11012.449377531251;11035;538693;549775;583748;586215;590697;73842.26157738462;84999.15000850036;89299;95352.52323738337;97472;1142.702897246722;1149.0348107589664;1164.0571137378581;1174.5243176513525;1198.3469009389903;17181.57046073858;17814.732779008067;17912.193951271962;17948.461546153638;18170.636587268444;41348;41726.58273417227;41879.58120418757;42598.57401425946;42673.57326426696;59670.701646493224;59722.104168438374;59773.40226597679;59855.401445984986;60711;8332.958335208285;8357.95821020891;8435.32517398619;8437.746867593982;8483.872741909;9104.90895091067;12751.171173873669;13247.668808279484;13694.246816425193;13768.65578360549;11485.942570287096;11631.534738610699;11842.46708898119;11928.582499612472;11998.2201156928;7976.561289129154;11471.967522922978;11516.94241528787;11791.29252244868;11898.22661526998;6420.036994450869;9509.191718703987;10985.670429887115;12056.819147712617;12157.452914618687;8017.679292828221;8296.70961516344;8538;8618.655253789779;8619.224269815746;11824.940875295568;11952.820707689218;12028.15802893789;12168.939155304166;12214.08394370408 02:26:29 INFO - PROCESS | 7895 | |3;mootools.html;1511.5994261520698;1546.8917175797692;1688.9746653800196;1830.112395488187;1832.688442964696;7340.302671246236;8139.267465928066;8148.266656000958;8276.83446331073;8366.414350995432;8195.508269503835;8217.301529369995;8301.128381519944;8309.667613295462;8321.459105158161;2341.4497593065616;2358.8348815582917;2360.44529535559;2363.468219650582;2363.7045369328835;2390.3665528634924;2408.759124087595;2413.8551686898754;2422.8909699063497;2425.357280320716;2410.240774156135;2415.2995631267;2440.5362981033545;2448.045262347686;2463.790577800889;2375.3586531636533;2418.153646223825;2426.4783071639595;2438.4635380216323;2453.570625140593;2383.892724827387;2393.628987506939;2417.468157005456;2423.09134074722;2426.2236084452984;8484.490930544187;8558.529280889548;8560;8563.957180214122;8590.570471476463;5214.582833373359;5293.602979776532;5294.444083371229;5322.760475778599;5335.839924802223;3525.312564050011;3556.626554211822;3603.6756691897854;3669.981650091759;3673.1368128489785;1181.2262967756133;1197.736497970445;1199.6940780101106;1222.4376786678138;1234.6110975042832;11785.705357366134;11840.407979600985;11901.523939042429;11925.40372981356;11976.940115299367;4551.0215303709865;4606.97696511522;4640.651951103613;4667.253239481666;4678.1813182692895;10200.081992620551;10293.794124117476;10303.330283531546;10305.484725763681;10320.587176512856;5323.787048518016;5324.5207931285595;5372.489613486712;5377.085895397791;5383.650062745909;4224.746515209097;4736.100140973204;4825.758712064383;4880.853574392703;4925.729084900365;3994.2610617035944;4080.591940805896;4087.141700242923;4164.68764842638;4197.643200327945;1245.4022069406735;1262.1795832708813;1271.3706715176047;1282.544696632682;1285.8135570342247;1024.5287167902848;1029.8352263637933;1049.5906596427399;1063.5586231713908;1066.0618655583037;5943.554233432424;6078.544109191828;6117.174181485531;6117.571769976148;6240.781572644935;475.1044281529342;478.5238687505954;480.48588010828774;484.78911673422175;487.0891433020275;4125.257453658311;4205.095904380573;4237.724547904377;4247.150569886036;4281.293586558183;10230.437325947145;10455.059044685862;10548.525316360628;10572.788544229072;10593.894061059445;10260.281780275458;10276.537555810006;10389;10392.220583456272;10409.635662751767;7940.205979402013;8013.398995075276;8033.879491807627;8062.838743225103;8077.919220807717;5783.6818974955095;5878.500327472042;5960.403959604005;5976;6025.87948241024;9158.77103072402;9341.673041443517;9344.065593440602;9357.157855793012;9382.249420046244;9220.723378298662;9434.48110353937;9552.85670714926;9578.9042109578;9631.807363852544;6620.735170593122;7126.643667816485;7417.592032438268;7708.961455192688;7761.650725717243;7980.162082981204;7991.120976692443;8025.317847982753;8038.517688938682;8069.798255043671;7111.359977602041;7320;7347.375473084634;7395.075615548057;7443.590602516913;7270.272972702687;7276.345128938421;7318.121825380988;7321.048263725682;7372.225916278928;6800.761973330909;6879.3120687930805;6906.792796216121;6913.10129683138;7030.894536582057;5072.51811077947;5154.355705536808;5170.069387510284;5192.324997750268;5210.557102646318;5138.254953031715;5191.091558977088;5252.684838909678;5265.78936842522;5303.655262407931 02:26:29 INFO - PROCESS | 7895 | |4;prototype.html;333.3466405844545;333.76969890775365;339.80461234789993;342.6402277608509;344.6243594482014;6582.539222254438;6672.199336079665;6673.432758215546;6674.4326732227755;6699.966500167505;6548;6553.115329430526;6568.704408301626;6574.506911981596;6579.473642108632;4759.381280433538;4801;4931.556159945604;4950.851474455754;4960.60315174787;4939.728314942677;4949.505049495057;4950.282209079682;4977.950220497785;4998.925016124761;4912.410510738717;4912.606991440694;4935;4941.110600091982;4943.406791185045;4907.435644900828;4913.852584422455;4931.284963680282;4939.333190019337;4939.925901111486;4313.892152696177;4325.372820940977;4326.762028088454;4334.50153232376;4335.848245311399;6166.414190651881;6265.122882796412;6292.874142517124;6300.716467758962;6323.241211054657;5719.885602287973;5735.426457354273;5738.167965644958;5743.396943320933;5744.195812586241;6826.795196144124;6830.795076147674;6874.896876546856;6878.243393226741;6879.552829066145;4754.23932170851;4760.238361862085;4768.165571025092;4768.904621907543;4769.833055843063;7207.063081799385;7221.061262035954;7240.565566066053;7242.23956484572;7251.492395532262;4756.286557016475;4856.295837103671;4862.82980095702;4863.1732605457155;4871.6846451457905;4909.975450122726;4933.50664933511;4933.802647894044;4934.1611925972675;4940.876478088005;5692.14617807324;5723.942760572341;5724.16999535065;5724.227229323988;5739.655620662774;6919.965400172967;6936.549124306904;6944.652767361713;6951.409130223988;6960.686769095403;1732.0733407626858;1754.982450175482;1757.578181236494;1760.6126652136509;1761.709317962522;1100.9705924960188;1143.3992410625192;1150.6605551362368;1150.9769804603861;1158.5771193514306;6736.393724564813;6788.1175447191545;6798.694058767367;6805.251422343538;6805.285445028299;7137.464690148156;7189;7190.352868241884;7202.603856787822;7212.639368031578;6864.176298844171;6872.965635171792;6873.072135261776;6882.346177113166;6887.070245516791;3926.3325234709596;3951.5060617422823;3959.6436320730695;3964.306246406867;3969.0672691917375;7616.543007419573;7624.885626715603;7625.923740762632;7632.46572739914;7647.197044310267;7296.598687072262;7450.925490745131;7482.176960534337;7489.513181643285;7502.324790768857;7578.583177925157;7597.620118994028;7605.581693006938;7610.8097297568;7616.885746713804;7291.781246562611;7292.453066020176;7294.854102918018;7300.087489063867;7311.597862117422;7111.964440177766;7126.893096603451;7140.85718285621;7146.714131434893;7180.712771489082;7471.252874712485;7616.657250423855;7616.80957976055;7618.352440042437;7638.197989211053;4652.069586082729;4660.510646382081;4677.953220467888;4680.368150299666;4695.976520117514;7282.235365286569;7288.271172882669;7291.744788932362;7292.598907060163;7293.124825021031;6969.860602788017;7024.8595028098125;7032.156141263081;7044.788656340318;7051.682674279772;6882.8623427532175;6987.755428559976;7027.402670773042;7035.542689725152;7040.049593304839;6889.965550172217;6899.310068993061;6903.240643529308;6915.481338899502;6917.23910369869;6967.8606427870145;7030.226675065636;7035.824104397431;7063.646817658993;7068.929310706827;6849.897251541331;6865.485088618473;6875.621840798804;6883.414909732729;6912.861742765217 02:26:29 INFO - PROCESS | 7895 | |5;yui.html;881.5504092912613;889.088684098799;929.419113054341;935.1863878425769;949.7293271417648;14453.92773036136;14546.418143274257;14568.125912445248;14619.634509137277;14649;13181.209127452335;13253.80119298209;13273.601791946257;13298.734025319513;13603;910.0808183734442;911.2891944283436;911.7128104647048;912.6805618033701;920.3787443475661;908.0783005249676;910.5856835139996;913.1644545241096;914.5564401265381;915.3775432705758;968.70454511374;968.8256113899495;969.839976403896;970.8689326940879;971.2763990826844;951.9762005949838;957.9233661307079;961.8364877970727;965.4882912056621;967.8790151231096;702.0136707925373;702.6908160409404;705.2172088981226;706.5089762614933;706.9257727938596;12601.621951341474;12620;12643.178193417398;12644.747105057848;12669.429875655618;12877.291748953803;13174.812330298648;13202.075854690176;13538.458461661521;14218.573442796629;11685;11752.23610465317;11945.880541194563;12003.879961200451;12806.48774049037;3980.24375368679;4027.8388864445387;4035.959640403588;4044.878653640366;4190.036291652937;51838.22242666363;55288;55705;56013.43986560123;59913.40086599165;11315.23654094729;11456.312621242585;11811.350375729246;11827.172097953233;11827.231229970024;18862.81137188638;18883.527911802314;18904;18904.62190756177;19118.808811911702;7865;7913.643886025143;7963.402744794048;8213.34293256538;8557.786055348666;4877.804887804519;4923.261510773341;4926.802927882844;4965.3048573199785;4978.128827455181;3618.909527261787;3636.5454318210222;3677.595464498903;3679;3694.9630503695157;655.4363247607054;659.3373659472296;669.0900375489427;687.5049964025993;699.1191099215025;682.5358756045937;689.162667359161;751.8947347371372;761.9180763316105;783.1463704562054;9636.325457218069;9655.710328690151;9799.902000979899;9810.705678829647;9883.752906177404;750.4034292737286;830.0369625834857;830.6054624053526;836.619338201117;850.4812064640564;4470.821167153277;4519.299508576176;4539.909201815945;4540.659450541222;4578.771061446914;63159;64468.67765661235;64913;64957.35042649513;65120.67439662866;52078.479215207364;52307.47692523026;55815.44184558184;56459.43540564624;58706;44976.3253551197;45067.54932450699;45532.77233613877;45665.31502027472;45793;9367.297452690938;9589.232861371212;9609.183219426428;10116.544755485873;10686.679399618024;38983.41524877186;39644;40329;40708.79645601753;40776.59223407728;45936.31095533637;47912.2813157796;50758.746206268734;50953.490465094874;51840.48159518356;12755.298458584495;12766.872331276569;12994.480220791062;13057;13245.139065960682;13886.513972010931;14059.929700351433;14185.432582696576;14303.141811490928;14347.210903400413;13399.732005359643;13650.453981841012;13675.863241367857;13921.58235252944;13943.233122178377;13683.657908551968;13775.517856874962;13790.517331893738;13840.100393474391;14043.297835108;13138.868611314147;13556.457741690221;13642.113262637897;13744.862551374757;13858.16850988944;11422.086233101498;11614.477348519167;11643.59247426336;11856.22934509254;11899.940500297444;11341.886581134084;11539.306762561115;11666.125040622157;11777.293362398283;11783.351915644722 02:26:29 INFO - PROCESS | 7895 | __end_tp_report 02:26:29 INFO - PROCESS | 7895 | __start_cc_report 02:26:29 INFO - PROCESS | 7895 | _x_x_mozilla_cycle_collect,343 02:26:29 INFO - PROCESS | 7895 | __end_cc_report 02:26:29 INFO - PROCESS | 7895 | __startTimestamp1465291589051__endTimestamp 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | ------- Summary: start ------- 02:26:29 INFO - PROCESS | 7895 | Number of tests: 6 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | [#0] dojo.html Cycles:165 Average:5654.54 Median:5851.50 stddev:628.11 (10.7%) stddev-sans-first:602.70 02:26:29 INFO - PROCESS | 7895 | Values: 3317.9 3371.7 3383.1 3412.6 3417.3 5686.3 5716.8 5723.9 5756.8 5771.4 5689.7 5693.5 5700.1 5723.4 5731.6 5145.3 5175.4 5244.8 5284.7 5293.3 5103.4 5179.0 5391.8 5393.0 5400.3 5299.8 5327.0 5348.6 5361.1 5371.7 5238.8 5264.8 5273.4 5277.3 5299.7 5060.9 5103.5 5137.5 5159.9 5172.0 5410.1 5416.7 5450.9 5470.7 5513.1 5953.9 5980.2 5981.6 5983.0 5998.9 5944.0 5982.0 6001.8 6039.1 6050.7 5642.1 5669.0 5686.5 5699.0 5707.0 6210.0 6232.2 6236.7 6236.8 6276.1 6024.0 6070.3 6090.4 6117.4 6128.5 6013.3 6030.8 6037.2 6040.8 6043.4 5906.4 5964.1 5985.9 5999.7 6008.5 6102.0 6129.8 6130.8 6142.5 6155.2 4631.2 4639.0 4642.7 4663.0 4674.5 4074.2 4097.5 4119.6 4155.3 4176.0 5797.5 5816.5 5851.9 5860.7 5942.3 5962.4 6046.5 6065.8 6067.6 6081.1 5838.2 5843.5 5853.8 5909.6 5913.7 5121.3 5134.4 5174.9 5184.5 5196.9 6240.5 6263.7 6278.4 6298.1 6317.2 5921.5 6066.4 6090.2 6092.2 6093.2 6370.3 6394.7 6420.7 6425.5 6427.0 6130.2 6132.0 6132.3 6133.1 6136.5 5951.0 6059.7 6135.0 6222.6 6233.3 5827.7 5844.9 5877.8 5884.7 5929.4 5835.2 5841.7 5845.0 5851.5 5879.9 5758.7 5782.9 5794.2 5867.6 5890.3 5890.2 5907.2 5939.2 5944.9 5964.1 5754.7 5759.5 5775.7 5775.9 5779.2 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | [#1] ext.html Cycles:180 Average:62335.36 Median:42414.29 stddev:135027.36 (318.4%) stddev-sans-first:135326.77 02:26:29 INFO - PROCESS | 7895 | Values: 670.8 680.6 689.4 733.4 747.5 32790.8 33778.7 39408.2 39983.2 40252.2 41947.0 42721.8 42780.4 42838.6 42864.1 8670.8 8866.2 8879.3 8899.2 8909.2 8719.7 8819.9 8851.1 8858.5 8870.5 9030.0 9146.8 9151.5 9169.1 9187.4 9075.9 9130.0 9132.7 9156.8 9159.9 8971.0 9042.5 9080.5 9083.2 9095.8 43626.0 43857.6 43897.6 43957.8 43979.8 3766.6 3792.3 3810.5 3857.7 4214.6 32973.3 33029.7 33196.0 33232.0 34556.7 4457.0 4498.2 4525.2 4526.4 4556.7 230821.0 231024.0 231434.0 232555.0 232645.0 56527.7 56704.7 57199.4 57341.0 57445.4 69214.0 71002.6 71151.6 71235.6 71242.6 17404.8 17529.5 17564.6 17587.4 17603.6 13359.5 13369.5 13370.4 13439.2 13478.6 19977.5 20105.0 20262.7 20285.2 20956.9 7538.3 7580.9 7625.0 7757.8 7762.5 1165.6 1183.4 1187.1 1189.4 1192.0 32332.0 32840.5 32976.2 33006.3 34061.7 1202.4 1205.6 1210.5 1236.2 1242.2 17172.7 17248.4 17302.9 17308.4 17365.5 554382.0 622606.0 637826.0 648301.0 969263.0 57593.4 58909.0 58970.0 58978.7 59023.0 1494.9 1509.2 1512.5 1520.9 1644.8 29936.7 30763.4 31059.0 31523.5 31881.8 52521.0 52646.5 53072.0 53093.5 53129.7 453510.0 457507.0 461533.0 462087.0 463335.0 29043.3 29339.6 31196.8 31258.7 31279.2 47930.8 48812.4 48954.3 49453.8 49824.3 41218.0 41704.6 42207.2 42844.6 43469.0 41691.0 41966.4 42229.8 42282.4 42454.8 41791.0 42070.2 42373.8 42910.4 42989.0 35984.0 36223.6 36519.5 36798.4 36899.0 28239.6 28481.1 28682.6 29083.4 29138.3 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | [#2] jquery.html Cycles:180 Average:32901.92 Median:34189.49 stddev:93688.07 (274.0%) stddev-sans-first:93919.11 02:26:29 INFO - PROCESS | 7895 | Values: 404.3 407.1 410.9 415.1 415.2 18455.3 19109.2 19132.9 19160.9 21250.5 20485.4 20514.6 20531.2 20727.8 20732.0 5763.4 5971.7 5981.3 7278.0 7629.2 7512.0 7516.9 7542.4 7543.9 7567.8 7326.5 7697.0 7718.2 7721.9 7729.4 7035.3 7343.6 7632.0 7694.0 7695.1 7084.3 7129.1 7141.5 7174.9 7176.7 25361.9 26382.7 26760.5 27443.3 27546.3 3123.9 3413.8 3450.4 3528.8 3562.2 15849.2 16057.9 16148.0 16461.5 16912.9 1989.3 2181.0 2207.5 2294.0 2353.0 94277.5 95347.0 97978.0 99125.5 99541.0 17740.4 19219.8 19892.7 20473.6 20514.4 33512.7 33672.0 33803.3 34142.1 34236.8 7575.8 7899.6 7993.2 8118.6 8198.9 7904.5 8073.7 8087.8 8105.8 8370.4 4723.9 4726.9 4747.1 4786.6 4839.3 1971.7 1986.3 1986.9 1997.6 2052.7 874.5 1000.0 1037.6 1057.4 1104.2 18583.3 18698.4 19452.5 19484.6 19739.8 1115.4 1119.7 1121.3 1144.9 1168.3 10788.9 10916.1 11008.7 11012.4 11035.0 538693.0 549775.0 583748.0 586215.0 590697.0 73842.3 84999.2 89299.0 95352.5 97472.0 1142.7 1149.0 1164.1 1174.5 1198.3 17181.6 17814.7 17912.2 17948.5 18170.6 41348.0 41726.6 41879.6 42598.6 42673.6 59670.7 59722.1 59773.4 59855.4 60711.0 8333.0 8358.0 8435.3 8437.7 8483.9 9104.9 12751.2 13247.7 13694.2 13768.7 11485.9 11631.5 11842.5 11928.6 11998.2 7976.6 11472.0 11516.9 11791.3 11898.2 6420.0 9509.2 10985.7 12056.8 12157.5 8017.7 8296.7 8538.0 8618.7 8619.2 11824.9 11952.8 12028.2 12168.9 12214.1 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | [#3] mootools.html Cycles:180 Average:5656.96 Median:2655.27 stddev:3096.54 (116.6%) stddev-sans-first:3089.55 02:26:29 INFO - PROCESS | 7895 | Values: 1511.6 1546.9 1689.0 1830.1 1832.7 7340.3 8139.3 8148.3 8276.8 8366.4 8195.5 8217.3 8301.1 8309.7 8321.5 2341.4 2358.8 2360.4 2363.5 2363.7 2390.4 2408.8 2413.9 2422.9 2425.4 2410.2 2415.3 2440.5 2448.0 2463.8 2375.4 2418.2 2426.5 2438.5 2453.6 2383.9 2393.6 2417.5 2423.1 2426.2 8484.5 8558.5 8560.0 8564.0 8590.6 5214.6 5293.6 5294.4 5322.8 5335.8 3525.3 3556.6 3603.7 3670.0 3673.1 1181.2 1197.7 1199.7 1222.4 1234.6 11785.7 11840.4 11901.5 11925.4 11976.9 4551.0 4607.0 4640.7 4667.3 4678.2 10200.1 10293.8 10303.3 10305.5 10320.6 5323.8 5324.5 5372.5 5377.1 5383.7 4224.7 4736.1 4825.8 4880.9 4925.7 3994.3 4080.6 4087.1 4164.7 4197.6 1245.4 1262.2 1271.4 1282.5 1285.8 1024.5 1029.8 1049.6 1063.6 1066.1 5943.6 6078.5 6117.2 6117.6 6240.8 475.1 478.5 480.5 484.8 487.1 4125.3 4205.1 4237.7 4247.2 4281.3 10230.4 10455.1 10548.5 10572.8 10593.9 10260.3 10276.5 10389.0 10392.2 10409.6 7940.2 8013.4 8033.9 8062.8 8077.9 5783.7 5878.5 5960.4 5976.0 6025.9 9158.8 9341.7 9344.1 9357.2 9382.2 9220.7 9434.5 9552.9 9578.9 9631.8 6620.7 7126.6 7417.6 7709.0 7761.7 7980.2 7991.1 8025.3 8038.5 8069.8 7111.4 7320.0 7347.4 7395.1 7443.6 7270.3 7276.3 7318.1 7321.0 7372.2 6800.8 6879.3 6906.8 6913.1 7030.9 5072.5 5154.4 5170.1 5192.3 5210.6 5138.3 5191.1 5252.7 5265.8 5303.7 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | [#4] prototype.html Cycles:180 Average:5835.85 Median:6762.26 stddev:1801.95 (26.6%) stddev-sans-first:1759.04 02:26:29 INFO - PROCESS | 7895 | Values: 333.3 333.8 339.8 342.6 344.6 6582.5 6672.2 6673.4 6674.4 6700.0 6548.0 6553.1 6568.7 6574.5 6579.5 4759.4 4801.0 4931.6 4950.9 4960.6 4939.7 4949.5 4950.3 4978.0 4998.9 4912.4 4912.6 4935.0 4941.1 4943.4 4907.4 4913.9 4931.3 4939.3 4939.9 4313.9 4325.4 4326.8 4334.5 4335.8 6166.4 6265.1 6292.9 6300.7 6323.2 5719.9 5735.4 5738.2 5743.4 5744.2 6826.8 6830.8 6874.9 6878.2 6879.6 4754.2 4760.2 4768.2 4768.9 4769.8 7207.1 7221.1 7240.6 7242.2 7251.5 4756.3 4856.3 4862.8 4863.2 4871.7 4910.0 4933.5 4933.8 4934.2 4940.9 5692.1 5723.9 5724.2 5724.2 5739.7 6920.0 6936.5 6944.7 6951.4 6960.7 1732.1 1755.0 1757.6 1760.6 1761.7 1101.0 1143.4 1150.7 1151.0 1158.6 6736.4 6788.1 6798.7 6805.3 6805.3 7137.5 7189.0 7190.4 7202.6 7212.6 6864.2 6873.0 6873.1 6882.3 6887.1 3926.3 3951.5 3959.6 3964.3 3969.1 7616.5 7624.9 7625.9 7632.5 7647.2 7296.6 7450.9 7482.2 7489.5 7502.3 7578.6 7597.6 7605.6 7610.8 7616.9 7291.8 7292.5 7294.9 7300.1 7311.6 7112.0 7126.9 7140.9 7146.7 7180.7 7471.3 7616.7 7616.8 7618.4 7638.2 4652.1 4660.5 4678.0 4680.4 4696.0 7282.2 7288.3 7291.7 7292.6 7293.1 6969.9 7024.9 7032.2 7044.8 7051.7 6882.9 6987.8 7027.4 7035.5 7040.0 6890.0 6899.3 6903.2 6915.5 6917.2 6967.9 7030.2 7035.8 7063.6 7068.9 6849.9 6865.5 6875.6 6883.4 6912.9 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - PROCESS | 7895 | [#5] yui.html Cycles:180 Average:15304.32 Median:4529.60 stddev:17466.35 (385.6%) stddev-sans-first:17481.76 02:26:29 INFO - PROCESS | 7895 | Values: 881.6 889.1 929.4 935.2 949.7 14453.9 14546.4 14568.1 14619.6 14649.0 13181.2 13253.8 13273.6 13298.7 13603.0 910.1 911.3 911.7 912.7 920.4 908.1 910.6 913.2 914.6 915.4 968.7 968.8 969.8 970.9 971.3 952.0 957.9 961.8 965.5 967.9 702.0 702.7 705.2 706.5 706.9 12601.6 12620.0 12643.2 12644.7 12669.4 12877.3 13174.8 13202.1 13538.5 14218.6 11685.0 11752.2 11945.9 12003.9 12806.5 3980.2 4027.8 4036.0 4044.9 4190.0 51838.2 55288.0 55705.0 56013.4 59913.4 11315.2 11456.3 11811.4 11827.2 11827.2 18862.8 18883.5 18904.0 18904.6 19118.8 7865.0 7913.6 7963.4 8213.3 8557.8 4877.8 4923.3 4926.8 4965.3 4978.1 3618.9 3636.5 3677.6 3679.0 3695.0 655.4 659.3 669.1 687.5 699.1 682.5 689.2 751.9 761.9 783.1 9636.3 9655.7 9799.9 9810.7 9883.8 750.4 830.0 830.6 836.6 850.5 4470.8 4519.3 4539.9 4540.7 4578.8 63159.0 64468.7 64913.0 64957.4 65120.7 52078.5 52307.5 55815.4 56459.4 58706.0 44976.3 45067.5 45532.8 45665.3 45793.0 9367.3 9589.2 9609.2 10116.5 10686.7 38983.4 39644.0 40329.0 40708.8 40776.6 45936.3 47912.3 50758.7 50953.5 51840.5 12755.3 12766.9 12994.5 13057.0 13245.1 13886.5 14059.9 14185.4 14303.1 14347.2 13399.7 13650.5 13675.9 13921.6 13943.2 13683.7 13775.5 13790.5 13840.1 14043.3 13138.9 13556.5 13642.1 13744.9 13858.2 11422.1 11614.5 11643.6 11856.2 11899.9 11341.9 11539.3 11666.1 11777.3 11783.4 02:26:29 INFO - PROCESS | 7895 | -------- Summary: end -------- 02:26:29 INFO - PROCESS | 7895 | 02:26:29 INFO - TEST-INFO | 7895: exit 0 02:26:29 INFO - TEST-OK | dromaeo_css | took 1109084ms 02:26:29 INFO - TEST-START | kraken 02:26:29 INFO - operating with platform_type : linux_ 02:26:29 INFO - Initialising browser for kraken test... 02:26:29 INFO - TEST-INFO | started process 8141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYcncg8/profile http://localhost:51479/getInfo.html) 02:26:33 INFO - PROCESS | 8141 | 02:26:33 INFO - PROCESS | 8141 | (process:8217): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:26:34 INFO - PROCESS | 8141 | __metrics Screen width/height:1600/1200 02:26:34 INFO - PROCESS | 8141 | colorDepth:24 02:26:34 INFO - PROCESS | 8141 | Browser inner width/height: 1024/697 02:26:34 INFO - PROCESS | 8141 | __metrics 02:26:35 ERROR - PROCESS | 8141 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:26:35 INFO - TEST-INFO | 8141: exit 0 02:26:35 INFO - Browser initialized. 02:26:35 INFO - Running cycle 1/1 for kraken test... 02:26:35 INFO - TEST-INFO | started process 8267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYcncg8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:37 INFO - PROCESS | 8267 | 02:26:37 INFO - PROCESS | 8267 | (process:8340): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:26:47 INFO - PROCESS | 8267 | RSS: Main: 150888448 02:26:47 INFO - PROCESS | 8267 | 02:26:50 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51479/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:50 INFO - PROCESS | 8267 | RSS: Main: 156471296 02:26:50 INFO - PROCESS | 8267 | 02:26:53 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51479/tests/kraken/driver.html?testName=audio-dft) 02:26:54 INFO - PROCESS | 8267 | RSS: Main: 156360704 02:26:54 INFO - PROCESS | 8267 | 02:26:57 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51479/tests/kraken/driver.html?testName=audio-fft) 02:26:57 INFO - PROCESS | 8267 | RSS: Main: 156549120 02:26:57 INFO - PROCESS | 8267 | 02:26:59 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51479/tests/kraken/driver.html?testName=audio-oscillator) 02:27:00 INFO - PROCESS | 8267 | RSS: Main: 156561408 02:27:00 INFO - PROCESS | 8267 | 02:27:02 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:03 INFO - PROCESS | 8267 | RSS: Main: 156749824 02:27:03 INFO - PROCESS | 8267 | 02:27:06 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51479/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:06 INFO - PROCESS | 8267 | RSS: Main: 156864512 02:27:06 INFO - PROCESS | 8267 | 02:27:10 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51479/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:10 INFO - PROCESS | 8267 | RSS: Main: 156745728 02:27:10 INFO - PROCESS | 8267 | 02:27:13 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51479/tests/kraken/driver.html?testName=json-parse-financial) 02:27:14 INFO - PROCESS | 8267 | RSS: Main: 156663808 02:27:14 INFO - PROCESS | 8267 | 02:27:15 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:16 INFO - PROCESS | 8267 | RSS: Main: 156172288 02:27:16 INFO - PROCESS | 8267 | 02:27:18 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:18 INFO - PROCESS | 8267 | RSS: Main: 156434432 02:27:18 INFO - PROCESS | 8267 | 02:27:20 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:21 INFO - PROCESS | 8267 | RSS: Main: 156876800 02:27:21 INFO - PROCESS | 8267 | 02:27:23 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:24 INFO - PROCESS | 8267 | RSS: Main: 157401088 02:27:24 INFO - PROCESS | 8267 | 02:27:27 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:27 INFO - PROCESS | 8267 | RSS: Main: 157425664 02:27:27 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | Cycle 1(1): loaded http://localhost:51479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51479/tests/kraken/driver.html?testName=ai-astar) 02:27:29 INFO - PROCESS | 8267 | RSS: Main: 158699520 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | __start_tp_report 02:27:29 INFO - PROCESS | 8267 | _x_x_mozilla_page_load 02:27:29 INFO - PROCESS | 8267 | _x_x_mozilla_page_load_details 02:27:29 INFO - PROCESS | 8267 | |i|pagename|runs| 02:27:29 INFO - PROCESS | 8267 | |0;ai-astar;109;110;104;109;111;112;101;110;111;111 02:27:29 INFO - PROCESS | 8267 | |1;audio-beat-detection;150;133;157;173;127;152;155;128;191;127 02:27:29 INFO - PROCESS | 8267 | |2;audio-dft;164;162;163;162;162;166;166;163;163;163 02:27:29 INFO - PROCESS | 8267 | |3;audio-fft;75;79;77;196;76;76;75;77;168;76 02:27:29 INFO - PROCESS | 8267 | |4;audio-oscillator;92;92;150;91;92;92;154;93;91;155 02:27:29 INFO - PROCESS | 8267 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 02:27:29 INFO - PROCESS | 8267 | |6;imaging-darkroom;146;148;147;148;147;149;147;146;146;146 02:27:29 INFO - PROCESS | 8267 | |7;imaging-desaturate;96;99;95;96;96;95;95;95;96;95 02:27:29 INFO - PROCESS | 8267 | |8;json-parse-financial;57;56;61;55;59;61;58;73;55;58 02:27:29 INFO - PROCESS | 8267 | |9;json-stringify-tinderbox;61;59;58;59;59;60;59;59;59;63 02:27:29 INFO - PROCESS | 8267 | |10;stanford-crypto-aes;74;71;72;74;75;75;82;75;74;74 02:27:29 INFO - PROCESS | 8267 | |11;stanford-crypto-ccm;114;117;116;117;117;112;114;115;134;139 02:27:29 INFO - PROCESS | 8267 | |12;stanford-crypto-pbkdf2;164;160;157;164;167;160;162;163;158;160 02:27:29 INFO - PROCESS | 8267 | |13;stanford-crypto-sha256-iterative;67;71;65;73;69;66;65;65;69;69 02:27:29 INFO - PROCESS | 8267 | __end_tp_report 02:27:29 INFO - PROCESS | 8267 | __start_cc_report 02:27:29 INFO - PROCESS | 8267 | _x_x_mozilla_cycle_collect,848 02:27:29 INFO - PROCESS | 8267 | __end_cc_report 02:27:29 INFO - PROCESS | 8267 | __startTimestamp1465291649696__endTimestamp 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | ------- Summary: start ------- 02:27:29 INFO - PROCESS | 8267 | Number of tests: 14 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:3.52 (3.2%) stddev-sans-first:3.73 02:27:29 INFO - PROCESS | 8267 | Values: 109.0 110.0 104.0 109.0 111.0 112.0 101.0 110.0 111.0 111.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.50 stddev:21.38 (13.9%) stddev-sans-first:22.68 02:27:29 INFO - PROCESS | 8267 | Values: 150.0 133.0 157.0 173.0 127.0 152.0 155.0 128.0 191.0 127.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 02:27:29 INFO - PROCESS | 8267 | Values: 164.0 162.0 163.0 162.0 162.0 166.0 166.0 163.0 163.0 163.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#3] audio-fft Cycles:10 Average:97.50 Median:76.00 stddev:45.04 (59.3%) stddev-sans-first:47.03 02:27:29 INFO - PROCESS | 8267 | Values: 75.0 79.0 77.0 196.0 76.0 76.0 75.0 77.0 168.0 76.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:92.00 stddev:29.57 (32.1%) stddev-sans-first:30.62 02:27:29 INFO - PROCESS | 8267 | Values: 92.0 92.0 150.0 91.0 92.0 92.0 154.0 93.0 91.0 155.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:27:29 INFO - PROCESS | 8267 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 02:27:29 INFO - PROCESS | 8267 | Values: 146.0 148.0 147.0 148.0 147.0 149.0 147.0 146.0 146.0 146.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.23 (1.3%) stddev-sans-first:1.30 02:27:29 INFO - PROCESS | 8267 | Values: 96.0 99.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:58.50 stddev:5.27 (9.0%) stddev-sans-first:5.53 02:27:29 INFO - PROCESS | 8267 | Values: 57.0 56.0 61.0 55.0 59.0 61.0 58.0 73.0 55.0 58.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:59.00 stddev:1.43 (2.4%) stddev-sans-first:1.42 02:27:29 INFO - PROCESS | 8267 | Values: 61.0 59.0 58.0 59.0 59.0 60.0 59.0 59.0 59.0 63.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.50 stddev:2.91 (3.9%) stddev-sans-first:3.08 02:27:29 INFO - PROCESS | 8267 | Values: 74.0 71.0 72.0 74.0 75.0 75.0 82.0 75.0 74.0 74.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:117.00 stddev:9.18 (7.8%) stddev-sans-first:9.52 02:27:29 INFO - PROCESS | 8267 | Values: 114.0 117.0 116.0 117.0 117.0 112.0 114.0 115.0 134.0 139.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.50 stddev:3.06 (1.9%) stddev-sans-first:3.11 02:27:29 INFO - PROCESS | 8267 | Values: 164.0 160.0 157.0 164.0 167.0 160.0 162.0 163.0 158.0 160.0 02:27:29 INFO - PROCESS | 8267 | 02:27:29 INFO - PROCESS | 8267 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:69.00 stddev:2.77 (4.0%) stddev-sans-first:2.92 02:27:29 INFO - PROCESS | 8267 | Values: 67.0 71.0 65.0 73.0 69.0 66.0 65.0 65.0 69.0 69.0 02:27:29 INFO - PROCESS | 8267 | -------- Summary: end -------- 02:27:29 INFO - PROCESS | 8267 | 02:27:30 INFO - TEST-INFO | 8267: exit 0 02:27:30 INFO - TEST-OK | kraken | took 60883ms 02:27:30 INFO - SUITE-END | took 1169s 02:27:30 INFO - Completed test suite (00:19:30) 02:27:30 INFO - javascript benchmark 02:27:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3317.850696718647, 3371.6796904294083, 3383.069655844643, 3412.6246112927556, 3417.29945361201, 5686.31764188298, 5716.828495145152, 5723.914141287884, 5756.798512052073, 5771.394003629616, 5689.743961521731, 5693.459121383462, 5700.1449782532645, 5723.370429252779, 5731.598788084836, 5145.3053837731895, 5175.404828444721, 5244.79020839166, 5284.735763211824, 5293.311869456985, 5103.362079740033, 5179.0, 5391.81128660497, 5393.029254734146, 5400.270963419927, 5299.814506492274, 5326.973365133169, 5348.572114230852, 5361.08861493547, 5371.731413429333, 5238.842834714946, 5264.8157314494, 5273.4462881397285, 5277.287566178594, 5299.655522391032, 5060.9493905060845, 5103.4896510349035, 5137.460566640524, 5159.896802063938, 5171.974140129313, 5410.1343784994215, 5416.674999500043, 5450.890982180374, 5470.7264636768, 5513.145462453286, 5953.910691339634, 5980.162777211194, 5981.58128930975, 5983.0, 5998.880022399571, 5943.970280148572, 5982.012967860298, 6001.819945401645, 6039.063945088518, 6050.727717252734, 5642.125470552071, 5669.036263835158, 5686.459786320334, 5698.971505142489, 5707.0, 6209.96895015522, 6232.189815323979, 6236.656983865841, 6236.844078897973, 6276.121343011982, 6023.969880150659, 6070.3019152798, 6090.390960903874, 6117.388261173936, 6128.540359473057, 6013.308469525973, 6030.758769649253, 6037.154798328237, 6040.818775436744, 6043.425874541911, 5906.379830117776, 5964.075568286922, 5985.910211346746, 5999.730012149464, 6008.549358798107, 6102.0, 6129.817282374534, 6130.826205142326, 6142.477889379364, 6155.230596175478, 4631.189541830234, 4638.976805115953, 4642.744649044267, 4663.0, 4674.462436819741, 4074.2462644410284, 4097.528784189856, 4119.629233369011, 4155.314373128461, 4176.0, 5797.536197104306, 5816.534677225812, 5851.941480585139, 5860.736266868002, 5942.3166335871065, 5962.403759624003, 6046.516278697693, 6065.75736970525, 6067.605605635619, 6081.148639190517, 5838.153467747153, 5843.474087332161, 5853.824385268449, 5909.586328957018, 5913.674747888821, 5121.257417674491, 5134.435212126663, 5174.922376164361, 5184.507471790174, 5196.948030519647, 6240.5319601030105, 6263.655498947511, 6278.4035516625845, 6298.149749783812, 6317.178766760384, 5921.496672782861, 6066.423689749467, 6090.23872015998, 6092.238470191226, 6093.177421048102, 6370.299267080525, 6394.680265986775, 6420.6789660517725, 6425.485961123192, 6427.0, 6130.172426722335, 6132.018876979661, 6132.2947860996555, 6133.141360209485, 6136.478399336106, 5950.9702451487465, 6059.72731227087, 6135.049067394561, 6222.595531290452, 6233.345498722569, 5827.679477628772, 5844.912326315194, 5877.764889404376, 5884.705764711662, 5929.377415371324, 5835.153902684172, 5841.707914604168, 5844.970775146097, 5851.502622276984, 5879.94120058811, 5758.712064396847, 5782.855428614318, 5794.2177805997335, 5867.647941123546, 5890.263717035371, 5890.2342695449315, 5907.202527658711, 5939.16851640762, 5944.851378715567, 5964.105384192232, 5754.6547207167705, 5759.481646651821, 5775.6823374714795, 5775.884482310246, 5779.162021506774], "value": 5613.332141025641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.7752902777569, 680.5780416141992, 689.4139981016134, 733.3619750816787, 747.4543583184277, 32790.836045819764, 33778.66221337786, 39408.2118357633, 39983.200335993264, 40252.19495610086, 41947.0, 42721.786391068, 42780.35829462553, 42838.57161428385, 42864.14271714564, 8670.783230419227, 8866.202041816236, 8879.28965682744, 8899.243564297043, 8909.242714369286, 8719.738407847743, 8819.911800882006, 8851.070637583058, 8858.468491890475, 8870.467771933672, 9029.95485022574, 9146.77133071672, 9151.496667683276, 9169.08309169081, 9187.402818816789, 9075.909240907606, 9130.0, 9132.726018219431, 9156.816863662689, 9159.908400915972, 8971.013188549254, 9042.457452552802, 9080.500572468512, 9083.182513573744, 9095.772605684844, 43626.0, 43857.56142438567, 43897.561024389666, 43957.78021109874, 43979.78010109961, 3766.642168993941, 3792.2984247914223, 3810.5046343975105, 3857.691384689218, 4214.599613036757, 32973.34053318944, 33029.66970330314, 33196.0, 33232.0, 34556.654433455595, 4456.977715111436, 4498.235299999008, 4525.185466616041, 4526.434195725535, 4556.681032327739, 230821.0, 231024.0, 231434.0, 232555.0, 232645.0, 56527.71736141293, 56704.71647641818, 57199.42800572024, 57341.0, 57445.42554574401, 69214.0, 71002.64498677473, 71151.64424177846, 71235.64382178056, 71242.64378678177, 17404.82595174032, 17529.474115776546, 17564.560885977953, 17587.384441544484, 17603.55991100233, 13359.465621375231, 13369.46522139123, 13370.39833207508, 13439.193648381128, 13478.595642130751, 19977.500562485762, 20105.0, 20262.69605955912, 20285.188592456136, 20956.89521552413, 7538.3215510604305, 7580.853945612509, 7625.0, 7757.7672669819995, 7762.456628035983, 1165.568739566349, 1183.3668987092037, 1187.1037366788191, 1189.3518032672214, 1191.9940400298117, 32332.0, 32840.50739238913, 32976.17559560982, 33006.3398732024, 34061.65938340585, 1202.446874437751, 1205.572021932219, 1210.5460452330376, 1236.208826351136, 1242.2174478712343, 17172.656546869242, 17248.396306129227, 17302.91348543249, 17308.394206202724, 17365.479035628698, 554382.0, 622606.0, 637826.0, 648301.0, 969263.0, 57593.424065759646, 58909.0, 58970.0, 58978.70510647505, 59023.0, 1494.880409567232, 1509.2227502835829, 1512.4857548433586, 1520.8935374523678, 1644.8272931342276, 29936.70063299339, 30763.384732305676, 31058.996771321188, 31523.52714709327, 31881.8405907969, 52521.0, 52646.473535265686, 53072.0, 53093.4690653104, 53129.734351328, 453510.0, 457507.0, 461533.0, 462087.0, 463335.0, 29043.273918152216, 29339.559906600993, 31196.844015779774, 31258.68741312649, 31279.218019549695, 47930.76034619805, 48812.40378271405, 48954.26568601403, 49453.75273123611, 49824.25263620976, 41218.0, 41704.58295417007, 42207.155856883306, 42844.57155428531, 43469.0, 41691.0, 41966.370504441846, 42229.78885105555, 42282.36576451417, 42454.78772606241, 41791.0, 42070.15859682851, 42373.78813105915, 42910.35634465423, 42989.0, 35984.0, 36223.63776362203, 36519.45220821743, 36798.44802328021, 36899.0, 28239.576406354332, 28481.145565633065, 28682.56976145318, 29083.41833163367, 29138.27154321159], "value": 20762.437575754244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.2763453418381, 407.0982773157456, 410.8644147431348, 415.1385874310805, 415.17885964868714, 18455.26178952842, 19109.235630574778, 19132.90433547834, 19160.904195479037, 21250.46873828155, 20485.385438436835, 20514.589708205865, 20531.178752849904, 20727.792722072776, 20732.0, 5763.423657634224, 5971.731272092767, 5981.28224613047, 7277.9636101819415, 7629.160792312841, 7512.0, 7516.887246691304, 7542.358899493523, 7543.886841697379, 7567.848643027136, 7326.4871458997895, 7696.961515192416, 7718.228177182293, 7721.922780772176, 7729.420293477983, 7035.296470352975, 7343.5961022143765, 7632.0, 7693.999780028588, 7695.0765908090825, 7084.291570842926, 7129.108861392326, 7141.500094993353, 7174.892376614355, 7176.712931482734, 25361.873190634113, 26382.73617263822, 26760.46479070427, 27443.31391715203, 27546.311342216406, 3123.859426325821, 3413.812240326781, 3450.396180668373, 3528.770629909048, 3562.1806984393475, 15849.207539622972, 16057.91971040149, 16148.0, 16461.506154815375, 16912.915435422743, 1989.333573252962, 2180.967285490719, 2207.4572497726404, 2293.9541209175723, 2352.952940941189, 94277.52861235719, 95347.0, 97978.0, 99125.50437247768, 99541.00458995462, 17740.379086731904, 19219.80780192208, 19892.70160947587, 20473.590528189354, 20514.38456846297, 33512.664873351445, 33672.0, 33803.32393352119, 34142.14644633854, 34236.82881585626, 7575.848483030309, 7899.565523896241, 7993.200679932076, 8118.594070296462, 8198.877016844752, 7904.525728456311, 8073.717419890393, 8087.83824323522, 8105.75682729519, 8370.372222083368, 4723.881902952385, 4726.85819425411, 4747.098051370298, 4786.64100192487, 4839.2983017462975, 1971.6549603819274, 1986.2948653228184, 1986.9006549672458, 1997.5805080933167, 2052.7023581580884, 874.510274246424, 1000.0499525450706, 1037.5642230263309, 1057.3602970202917, 1104.1829046505527, 18583.34958276454, 18698.43904682862, 19452.51368715765, 19484.61030779405, 19739.802601973795, 1115.358668765463, 1119.7200699825044, 1121.2879821313525, 1144.9427528623535, 1168.3340495917246, 10788.8573279513, 10916.126709863192, 11008.669739907815, 11012.449377531251, 11035.0, 538693.0, 549775.0, 583748.0, 586215.0, 590697.0, 73842.26157738462, 84999.15000850036, 89299.0, 95352.52323738337, 97472.0, 1142.702897246722, 1149.0348107589664, 1164.0571137378581, 1174.5243176513525, 1198.3469009389903, 17181.57046073858, 17814.732779008067, 17912.193951271962, 17948.461546153638, 18170.636587268444, 41348.0, 41726.58273417227, 41879.58120418757, 42598.57401425946, 42673.57326426696, 59670.701646493224, 59722.104168438374, 59773.40226597679, 59855.401445984986, 60711.0, 8332.958335208285, 8357.95821020891, 8435.32517398619, 8437.746867593982, 8483.872741909, 9104.90895091067, 12751.171173873669, 13247.668808279484, 13694.246816425193, 13768.65578360549, 11485.942570287096, 11631.534738610699, 11842.46708898119, 11928.582499612472, 11998.2201156928, 7976.561289129154, 11471.967522922978, 11516.94241528787, 11791.29252244868, 11898.22661526998, 6420.036994450869, 9509.191718703987, 10985.670429887115, 12056.819147712617, 12157.452914618687, 8017.679292828221, 8296.70961516344, 8538.0, 8618.655253789779, 8619.224269815746, 11824.940875295568, 11952.820707689218, 12028.15802893789, 12168.939155304166, 12214.08394370408], "value": 10380.540654400973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.5994261520698, 1546.8917175797692, 1688.9746653800196, 1830.112395488187, 1832.688442964696, 7340.302671246236, 8139.267465928066, 8148.266656000958, 8276.83446331073, 8366.414350995432, 8195.508269503835, 8217.301529369995, 8301.128381519944, 8309.667613295462, 8321.459105158161, 2341.4497593065616, 2358.8348815582917, 2360.44529535559, 2363.468219650582, 2363.7045369328835, 2390.3665528634924, 2408.759124087595, 2413.8551686898754, 2422.8909699063497, 2425.357280320716, 2410.240774156135, 2415.2995631267, 2440.5362981033545, 2448.045262347686, 2463.790577800889, 2375.3586531636533, 2418.153646223825, 2426.4783071639595, 2438.4635380216323, 2453.570625140593, 2383.892724827387, 2393.628987506939, 2417.468157005456, 2423.09134074722, 2426.2236084452984, 8484.490930544187, 8558.529280889548, 8560.0, 8563.957180214122, 8590.570471476463, 5214.582833373359, 5293.602979776532, 5294.444083371229, 5322.760475778599, 5335.839924802223, 3525.312564050011, 3556.626554211822, 3603.6756691897854, 3669.981650091759, 3673.1368128489785, 1181.2262967756133, 1197.736497970445, 1199.6940780101106, 1222.4376786678138, 1234.6110975042832, 11785.705357366134, 11840.407979600985, 11901.523939042429, 11925.40372981356, 11976.940115299367, 4551.0215303709865, 4606.97696511522, 4640.651951103613, 4667.253239481666, 4678.1813182692895, 10200.081992620551, 10293.794124117476, 10303.330283531546, 10305.484725763681, 10320.587176512856, 5323.787048518016, 5324.5207931285595, 5372.489613486712, 5377.085895397791, 5383.650062745909, 4224.746515209097, 4736.100140973204, 4825.758712064383, 4880.853574392703, 4925.729084900365, 3994.2610617035944, 4080.591940805896, 4087.141700242923, 4164.68764842638, 4197.643200327945, 1245.4022069406735, 1262.1795832708813, 1271.3706715176047, 1282.544696632682, 1285.8135570342247, 1024.5287167902848, 1029.8352263637933, 1049.5906596427399, 1063.5586231713908, 1066.0618655583037, 5943.554233432424, 6078.544109191828, 6117.174181485531, 6117.571769976148, 6240.781572644935, 475.1044281529342, 478.5238687505954, 480.48588010828774, 484.78911673422175, 487.0891433020275, 4125.257453658311, 4205.095904380573, 4237.724547904377, 4247.150569886036, 4281.293586558183, 10230.437325947145, 10455.059044685862, 10548.525316360628, 10572.788544229072, 10593.894061059445, 10260.281780275458, 10276.537555810006, 10389.0, 10392.220583456272, 10409.635662751767, 7940.205979402013, 8013.398995075276, 8033.879491807627, 8062.838743225103, 8077.919220807717, 5783.6818974955095, 5878.500327472042, 5960.403959604005, 5976.0, 6025.87948241024, 9158.77103072402, 9341.673041443517, 9344.065593440602, 9357.157855793012, 9382.249420046244, 9220.723378298662, 9434.48110353937, 9552.85670714926, 9578.9042109578, 9631.807363852544, 6620.735170593122, 7126.643667816485, 7417.592032438268, 7708.961455192688, 7761.650725717243, 7980.162082981204, 7991.120976692443, 8025.317847982753, 8038.517688938682, 8069.798255043671, 7111.359977602041, 7320.0, 7347.375473084634, 7395.075615548057, 7443.590602516913, 7270.272972702687, 7276.345128938421, 7318.121825380988, 7321.048263725682, 7372.225916278928, 6800.761973330909, 6879.3120687930805, 6906.792796216121, 6913.10129683138, 7030.894536582057, 5072.51811077947, 5154.355705536808, 5170.069387510284, 5192.324997750268, 5210.557102646318, 5138.254953031715, 5191.091558977088, 5252.684838909678, 5265.78936842522, 5303.655262407931], "value": 4543.077074062253, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.3466405844545, 333.76969890775365, 339.80461234789993, 342.6402277608509, 344.6243594482014, 6582.539222254438, 6672.199336079665, 6673.432758215546, 6674.4326732227755, 6699.966500167505, 6548.0, 6553.115329430526, 6568.704408301626, 6574.506911981596, 6579.473642108632, 4759.381280433538, 4801.0, 4931.556159945604, 4950.851474455754, 4960.60315174787, 4939.728314942677, 4949.505049495057, 4950.282209079682, 4977.950220497785, 4998.925016124761, 4912.410510738717, 4912.606991440694, 4935.0, 4941.110600091982, 4943.406791185045, 4907.435644900828, 4913.852584422455, 4931.284963680282, 4939.333190019337, 4939.925901111486, 4313.892152696177, 4325.372820940977, 4326.762028088454, 4334.50153232376, 4335.848245311399, 6166.414190651881, 6265.122882796412, 6292.874142517124, 6300.716467758962, 6323.241211054657, 5719.885602287973, 5735.426457354273, 5738.167965644958, 5743.396943320933, 5744.195812586241, 6826.795196144124, 6830.795076147674, 6874.896876546856, 6878.243393226741, 6879.552829066145, 4754.23932170851, 4760.238361862085, 4768.165571025092, 4768.904621907543, 4769.833055843063, 7207.063081799385, 7221.061262035954, 7240.565566066053, 7242.23956484572, 7251.492395532262, 4756.286557016475, 4856.295837103671, 4862.82980095702, 4863.1732605457155, 4871.6846451457905, 4909.975450122726, 4933.50664933511, 4933.802647894044, 4934.1611925972675, 4940.876478088005, 5692.14617807324, 5723.942760572341, 5724.16999535065, 5724.227229323988, 5739.655620662774, 6919.965400172967, 6936.549124306904, 6944.652767361713, 6951.409130223988, 6960.686769095403, 1732.0733407626858, 1754.982450175482, 1757.578181236494, 1760.6126652136509, 1761.709317962522, 1100.9705924960188, 1143.3992410625192, 1150.6605551362368, 1150.9769804603861, 1158.5771193514306, 6736.393724564813, 6788.1175447191545, 6798.694058767367, 6805.251422343538, 6805.285445028299, 7137.464690148156, 7189.0, 7190.352868241884, 7202.603856787822, 7212.639368031578, 6864.176298844171, 6872.965635171792, 6873.072135261776, 6882.346177113166, 6887.070245516791, 3926.3325234709596, 3951.5060617422823, 3959.6436320730695, 3964.306246406867, 3969.0672691917375, 7616.543007419573, 7624.885626715603, 7625.923740762632, 7632.46572739914, 7647.197044310267, 7296.598687072262, 7450.925490745131, 7482.176960534337, 7489.513181643285, 7502.324790768857, 7578.583177925157, 7597.620118994028, 7605.581693006938, 7610.8097297568, 7616.885746713804, 7291.781246562611, 7292.453066020176, 7294.854102918018, 7300.087489063867, 7311.597862117422, 7111.964440177766, 7126.893096603451, 7140.85718285621, 7146.714131434893, 7180.712771489082, 7471.252874712485, 7616.657250423855, 7616.80957976055, 7618.352440042437, 7638.197989211053, 4652.069586082729, 4660.510646382081, 4677.953220467888, 4680.368150299666, 4695.976520117514, 7282.235365286569, 7288.271172882669, 7291.744788932362, 7292.598907060163, 7293.124825021031, 6969.860602788017, 7024.8595028098125, 7032.156141263081, 7044.788656340318, 7051.682674279772, 6882.8623427532175, 6987.755428559976, 7027.402670773042, 7035.542689725152, 7040.049593304839, 6889.965550172217, 6899.310068993061, 6903.240643529308, 6915.481338899502, 6917.23910369869, 6967.8606427870145, 7030.226675065636, 7035.824104397431, 7063.646817658993, 7068.929310706827, 6849.897251541331, 6865.485088618473, 6875.621840798804, 6883.414909732729, 6912.861742765217], "value": 5237.274944957983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.5504092912613, 889.088684098799, 929.419113054341, 935.1863878425769, 949.7293271417648, 14453.92773036136, 14546.418143274257, 14568.125912445248, 14619.634509137277, 14649.0, 13181.209127452335, 13253.80119298209, 13273.601791946257, 13298.734025319513, 13603.0, 910.0808183734442, 911.2891944283436, 911.7128104647048, 912.6805618033701, 920.3787443475661, 908.0783005249676, 910.5856835139996, 913.1644545241096, 914.5564401265381, 915.3775432705758, 968.70454511374, 968.8256113899495, 969.839976403896, 970.8689326940879, 971.2763990826844, 951.9762005949838, 957.9233661307079, 961.8364877970727, 965.4882912056621, 967.8790151231096, 702.0136707925373, 702.6908160409404, 705.2172088981226, 706.5089762614933, 706.9257727938596, 12601.621951341474, 12620.0, 12643.178193417398, 12644.747105057848, 12669.429875655618, 12877.291748953803, 13174.812330298648, 13202.075854690176, 13538.458461661521, 14218.573442796629, 11685.0, 11752.23610465317, 11945.880541194563, 12003.879961200451, 12806.48774049037, 3980.24375368679, 4027.8388864445387, 4035.959640403588, 4044.878653640366, 4190.036291652937, 51838.22242666363, 55288.0, 55705.0, 56013.43986560123, 59913.40086599165, 11315.23654094729, 11456.312621242585, 11811.350375729246, 11827.172097953233, 11827.231229970024, 18862.81137188638, 18883.527911802314, 18904.0, 18904.62190756177, 19118.808811911702, 7865.0, 7913.643886025143, 7963.402744794048, 8213.34293256538, 8557.786055348666, 4877.804887804519, 4923.261510773341, 4926.802927882844, 4965.3048573199785, 4978.128827455181, 3618.909527261787, 3636.5454318210222, 3677.595464498903, 3679.0, 3694.9630503695157, 655.4363247607054, 659.3373659472296, 669.0900375489427, 687.5049964025993, 699.1191099215025, 682.5358756045937, 689.162667359161, 751.8947347371372, 761.9180763316105, 783.1463704562054, 9636.325457218069, 9655.710328690151, 9799.902000979899, 9810.705678829647, 9883.752906177404, 750.4034292737286, 830.0369625834857, 830.6054624053526, 836.619338201117, 850.4812064640564, 4470.821167153277, 4519.299508576176, 4539.909201815945, 4540.659450541222, 4578.771061446914, 63159.0, 64468.67765661235, 64913.0, 64957.35042649513, 65120.67439662866, 52078.479215207364, 52307.47692523026, 55815.44184558184, 56459.43540564624, 58706.0, 44976.3253551197, 45067.54932450699, 45532.77233613877, 45665.31502027472, 45793.0, 9367.297452690938, 9589.232861371212, 9609.183219426428, 10116.544755485873, 10686.679399618024, 38983.41524877186, 39644.0, 40329.0, 40708.79645601753, 40776.59223407728, 45936.31095533637, 47912.2813157796, 50758.746206268734, 50953.490465094874, 51840.48159518356, 12755.298458584495, 12766.872331276569, 12994.480220791062, 13057.0, 13245.139065960682, 13886.513972010931, 14059.929700351433, 14185.432582696576, 14303.141811490928, 14347.210903400413, 13399.732005359643, 13650.453981841012, 13675.863241367857, 13921.58235252944, 13943.233122178377, 13683.657908551968, 13775.517856874962, 13790.517331893738, 13840.100393474391, 14043.297835108, 13138.868611314147, 13556.457741690221, 13642.113262637897, 13744.862551374757, 13858.16850988944, 11422.086233101498, 11614.477348519167, 11643.59247426336, 11856.22934509254, 11899.940500297444, 11341.886581134084, 11539.306762561115, 11666.125040622157, 11777.293362398283, 11783.351915644722], "value": 7136.5653448702415, "unit": "score"}], "name": "dromaeo_css", "value": 7681.582050021441, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 104.0, 109.0, 111.0, 112.0, 101.0, 110.0, 111.0, 111.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 157.0, 173.0, 127.0, 152.0, 155.0, 128.0, 191.0, 127.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 162.0, 162.0, 166.0, 166.0, 163.0, 163.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 77.0, 196.0, 76.0, 76.0, 75.0, 77.0, 168.0, 76.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 91.0, 92.0, 92.0, 154.0, 93.0, 91.0, 155.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 147.0, 149.0, 147.0, 146.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 61.0, 55.0, 59.0, 61.0, 58.0, 73.0, 55.0, 58.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 63.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 72.0, 74.0, 75.0, 75.0, 82.0, 75.0, 74.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 116.0, 117.0, 117.0, 112.0, 114.0, 115.0, 134.0, 139.0], "value": 119.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 157.0, 164.0, 167.0, 160.0, 162.0, 163.0, 158.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 65.0, 73.0, 69.0, 66.0, 65.0, 65.0, 69.0, 69.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1531.5, "alertThreshold": 2.0}]} 02:27:30 INFO - Return code: 0 02:27:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:31 ERROR - # TBPL SUCCESS # 02:27:31 INFO - Running post-action listener: _resource_record_post_action 02:27:31 INFO - Running post-run listener: _resource_record_post_run 02:27:32 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 36864; Write bytes: 462950400; Read time: 444; Write time: 328004 02:27:32 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 32768; Write bytes: 242507776; Read time: 432; Write time: 206424 02:27:32 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220442624; Read time: 12; Write time: 121580 02:27:32 INFO - Running post-run listener: _upload_blobber_files 02:27:32 INFO - Blob upload gear active. 02:27:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:32 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:27:32 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:27:32 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:27:32 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:33 INFO - (blobuploader) - INFO - Done attempting. 02:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:27:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:34 INFO - (blobuploader) - INFO - Done attempting. 02:27:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:34 INFO - Return code: 0 02:27:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53d6eda922f531327244c86307a1dbf642a91956c0804024dda16eb1793b3cc3806c7364ecc9e8207e8fe435c02c1a13c6f0c254169be34a14d834ea110c8164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d382d702489eca14a42d645e0de163bc8291d71994ea8e18e624d84034ffcaf60226740e5344140ee2a10083cee86782524c303f8848a74b92337441784ee08"} 02:27:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:34 INFO - Contents: 02:27:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53d6eda922f531327244c86307a1dbf642a91956c0804024dda16eb1793b3cc3806c7364ecc9e8207e8fe435c02c1a13c6f0c254169be34a14d834ea110c8164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d382d702489eca14a42d645e0de163bc8291d71994ea8e18e624d84034ffcaf60226740e5344140ee2a10083cee86782524c303f8848a74b92337441784ee08"} 02:27:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:34 INFO - Copying logs to upload dir... 02:27:34 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.539628 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-07 02:27:34.126521) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:34.130141) ========= 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=836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990 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/53d6eda922f531327244c86307a1dbf642a91956c0804024dda16eb1793b3cc3806c7364ecc9e8207e8fe435c02c1a13c6f0c254169be34a14d834ea110c8164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d382d702489eca14a42d645e0de163bc8291d71994ea8e18e624d84034ffcaf60226740e5344140ee2a10083cee86782524c303f8848a74b92337441784ee08"} 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.011427 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/53d6eda922f531327244c86307a1dbf642a91956c0804024dda16eb1793b3cc3806c7364ecc9e8207e8fe435c02c1a13c6f0c254169be34a14d834ea110c8164", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d382d702489eca14a42d645e0de163bc8291d71994ea8e18e624d84034ffcaf60226740e5344140ee2a10083cee86782524c303f8848a74b92337441784ee08"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:34.160750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:34.162000) ========= 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=836cfdc75598d54cb747368e000001a9-1465290426.638632-834945990 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004672 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:27:34.240744) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:27:34.241083) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:27:34.241399) ========= ========= Total master_lag: 0.18 =========