builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1462473726.07 results: success (0) buildid: 20160505084822 builduid: bc18aab6e2f342438249157ea6d5ef64 revision: ce2501a5f268283105549cc5316a35ca938c099f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.069513) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.070059) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.070352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.091458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.091866) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 11:42:06-- 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% 23.7M=0s 2016-05-05 11:42:06 (23.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217268 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.329603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.332972) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.085705 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.432884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:06.433336) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ce2501a5f268283105549cc5316a35ca938c099f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ce2501a5f268283105549cc5316a35ca938c099f --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=97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 11:42:06,495 truncating revision to first 12 chars 2016-05-05 11:42:06,495 Setting DEBUG logging. 2016-05-05 11:42:06,495 attempt 1/10 2016-05-05 11:42:06,495 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ce2501a5f268?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 11:42:06,761 unpacking tar archive at: fx-team-ce2501a5f268/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562920 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:07.009641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:07.013177) ========= script_repo_revision: ce2501a5f268283105549cc5316a35ca938c099f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:07.013705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:07.014006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 11:42:07.026350) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-05 11:42:07.026838) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:42:07 INFO - MultiFileLogger online at 20160505 11:42:07 in /builds/slave/test 11:42:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:42:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:42:07 INFO - {'append_to_log': False, 11:42:07 INFO - 'base_work_dir': '/builds/slave/test', 11:42:07 INFO - 'blob_upload_branch': 'Fx-Team', 11:42:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:42:07 INFO - 'branch': 'Fx-Team', 11:42:07 INFO - 'buildbot_json_path': 'buildprops.json', 11:42:07 INFO - 'config_files': ('talos/linux_config.py',), 11:42:07 INFO - 'default_actions': ('clobber', 11:42:07 INFO - 'read-buildbot-config', 11:42:07 INFO - 'download-and-extract', 11:42:07 INFO - 'populate-webroot', 11:42:07 INFO - 'create-virtualenv', 11:42:07 INFO - 'install', 11:42:07 INFO - 'run-tests'), 11:42:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:42:07 INFO - 'download_minidump_stackwalk': True, 11:42:07 INFO - 'download_symbols': 'ondemand', 11:42:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:42:07 INFO - 'tooltool.py': '/tools/tooltool.py', 11:42:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:42:07 INFO - '/tools/misc-python/virtualenv.py')}, 11:42:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:42:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:42:07 INFO - 'installer_path': 'installer.exe', 11:42:07 INFO - 'log_level': 'info', 11:42:07 INFO - 'log_name': 'talos', 11:42:07 INFO - 'log_to_console': True, 11:42:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:42:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:42:07 INFO - 'opt_config_files': (), 11:42:07 INFO - 'pip_index': False, 11:42:07 INFO - 'sps_profile': False, 11:42:07 INFO - 'sps_profile_interval': 0, 11:42:07 INFO - 'suite': 'dromaeojs-e10s', 11:42:07 INFO - 'system_bits': '32', 11:42:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:42:07 INFO - 'title': 'talos-linux64-ix-068', 11:42:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:42:07 INFO - 'use_talos_json': True, 11:42:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:42:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:42:07 INFO - 'work_dir': 'build'} 11:42:07 INFO - ##### 11:42:07 INFO - ##### Running clobber step. 11:42:07 INFO - ##### 11:42:07 INFO - Running pre-action listener: _resource_record_pre_action 11:42:07 INFO - Running main action method: clobber 11:42:07 INFO - rmtree: /builds/slave/test/build 11:42:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:42:08 INFO - Running post-action listener: _resource_record_post_action 11:42:08 INFO - ##### 11:42:08 INFO - ##### Running read-buildbot-config step. 11:42:08 INFO - ##### 11:42:08 INFO - Running pre-action listener: _resource_record_pre_action 11:42:08 INFO - Running main action method: read_buildbot_config 11:42:08 INFO - Using buildbot properties: 11:42:08 INFO - { 11:42:08 INFO - "project": "", 11:42:08 INFO - "product": "firefox", 11:42:08 INFO - "script_repo_revision": "production", 11:42:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:42:08 INFO - "repository": "", 11:42:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:42:08 INFO - "buildid": "20160505084822", 11:42:08 INFO - "pgo_build": "True", 11:42:08 INFO - "basedir": "/builds/slave/test", 11:42:08 INFO - "buildnumber": 724, 11:42:08 INFO - "slavename": "talos-linux64-ix-068", 11:42:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:42:08 INFO - "platform": "ubuntu64_hw", 11:42:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:42:08 INFO - "branch": "fx-team", 11:42:08 INFO - "repo_path": "integration/fx-team", 11:42:08 INFO - "revision": "ce2501a5f268283105549cc5316a35ca938c099f", 11:42:08 INFO - "stage_platform": "linux64-pgo", 11:42:08 INFO - "builduid": "bc18aab6e2f342438249157ea6d5ef64", 11:42:08 INFO - "slavebuilddir": "test" 11:42:08 INFO - } 11:42:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:42:08 INFO - Running post-action listener: _resource_record_post_action 11:42:08 INFO - ##### 11:42:08 INFO - ##### Running download-and-extract step. 11:42:08 INFO - ##### 11:42:08 INFO - Running pre-action listener: _resource_record_pre_action 11:42:08 INFO - Running main action method: download_and_extract 11:42:08 INFO - mkdir: /builds/slave/test/build/tests 11:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:08 INFO - https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:42:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:42:09 INFO - Downloaded 1361 bytes. 11:42:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:42:09 INFO - Using the following test package requirements: 11:42:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:42:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:42:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'jsshell-linux-x86_64.zip'], 11:42:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:42:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:42:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:42:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:42:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:42:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:42:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:42:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:42: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')]} 11:42:09 INFO - https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:42:10 INFO - Downloaded 23880109 bytes. 11:42:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:42:11 INFO - Return code: 0 11:42:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:42:11 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')]} 11:42:11 INFO - https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:42:12 INFO - Downloaded 23880109 bytes. 11:42:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:42:16 INFO - Return code: 0 11:42: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')]} 11:42:16 INFO - https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:42:17 INFO - Downloaded 10840152 bytes. 11:42:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:42:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:42:17 INFO - Return code: 0 11:42:17 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')]} 11:42:17 INFO - https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:42:18 INFO - Downloaded 58415402 bytes. 11:42:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:18 INFO - mkdir: /builds/slave/test/properties 11:42:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:42:18 INFO - Writing to file /builds/slave/test/properties/build_url 11:42:18 INFO - Contents: 11:42:18 INFO - build_url:https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:42:19 INFO - Running post-action listener: _resource_record_post_action 11:42:19 INFO - Running post-action listener: set_extra_try_arguments 11:42:19 INFO - ##### 11:42:19 INFO - ##### Running populate-webroot step. 11:42:19 INFO - ##### 11:42:19 INFO - Running pre-action listener: _resource_record_pre_action 11:42:19 INFO - Running main action method: populate_webroot 11:42:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:42:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:42:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:42:19 INFO - '--tppagecycles', 11:42:19 INFO - '7'], 11:42:19 INFO - 'tests': ['tsvgm']}}, 11:42:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:42:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:42:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:42:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:42:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:42:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['damp', 'tps']}, 11:42:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['damp', 'tps']}, 11:42:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['dromaeo_dom']}, 11:42:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:42:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['a11yr', 11:42:19 INFO - 'ts_paint', 11:42:19 INFO - 'tpaint', 11:42:19 INFO - 'sessionrestore', 11:42:19 INFO - 'sessionrestore_no_auto_restore', 11:42:19 INFO - 'tabpaint']}, 11:42:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['tsvgx', 11:42:19 INFO - 'tsvgr_opacity', 11:42:19 INFO - 'tart', 11:42:19 INFO - 'tscrollx', 11:42:19 INFO - 'cart']}, 11:42:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:42:19 INFO - 'tsvgr_opacity', 11:42:19 INFO - 'tart', 11:42:19 INFO - 'tscrollx', 11:42:19 INFO - 'cart']}, 11:42:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--disable-e10s'], 11:42:19 INFO - 'tests': ['tp5o']}, 11:42:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'tests': ['tp5o']}, 11:42:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--disable-e10s', 11:42:19 INFO - '--xperf_path', 11:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:19 INFO - 'tests': ['tp5n']}, 11:42:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:42:19 INFO - 'talos_options': ['--xperf_path', 11:42:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:42:19 INFO - 'tests': ['tp5n']}}, 11:42:19 INFO - 'talos.zip': {'path': '', 11:42:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:42:19 INFO - Running post-action listener: _resource_record_post_action 11:42:19 INFO - ##### 11:42:19 INFO - ##### Running create-virtualenv step. 11:42:19 INFO - ##### 11:42:19 INFO - Running pre-action listener: _resource_record_pre_action 11:42:19 INFO - Running main action method: create_virtualenv 11:42:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:42:19 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 11:42:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:42:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:42:20 INFO - Using real prefix '/usr' 11:42:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:42:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:42:23 INFO - Installing pip.................done. 11:42:23 INFO - Return code: 0 11:42:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:42: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')]} 11:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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')]} 11:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42: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', 'pip>=1.5'] in /builds/slave/test/build 11:42: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 pip>=1.5 11:42:23 INFO - Using env: {'DISPLAY': ':0', 11:42:23 INFO - 'HOME': '/home/cltbld', 11:42:23 INFO - 'LANG': 'en_US.UTF-8', 11:42:23 INFO - 'LANGUAGE': 'en_US:en', 11:42:23 INFO - 'LOGNAME': 'cltbld', 11:42:23 INFO - 'MAIL': '/var/mail/cltbld', 11:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:23 INFO - 'MOZ_NO_REMOTE': '1', 11:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:23 INFO - 'NO_EM_RESTART': '1', 11:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:23 INFO - 'PWD': '/builds/slave/test', 11:42:23 INFO - 'SHELL': '/bin/bash', 11:42:23 INFO - 'SHLVL': '1', 11:42:23 INFO - 'TERM': 'linux', 11:42:23 INFO - 'TMOUT': '86400', 11:42:23 INFO - 'USER': 'cltbld', 11:42:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:23 INFO - '_': '/tools/buildbot/bin/python'} 11:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:26 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 11:42:26 INFO - Cleaning up... 11:42:26 INFO - Return code: 0 11:42:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:42:26 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')]} 11:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:26 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')]} 11:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:26 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 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:26 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 11:42:26 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 11:42:26 INFO - Using env: {'DISPLAY': ':0', 11:42:26 INFO - 'HOME': '/home/cltbld', 11:42:26 INFO - 'LANG': 'en_US.UTF-8', 11:42:26 INFO - 'LANGUAGE': 'en_US:en', 11:42:26 INFO - 'LOGNAME': 'cltbld', 11:42:26 INFO - 'MAIL': '/var/mail/cltbld', 11:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:26 INFO - 'MOZ_NO_REMOTE': '1', 11:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:26 INFO - 'NO_EM_RESTART': '1', 11:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:26 INFO - 'PWD': '/builds/slave/test', 11:42:26 INFO - 'SHELL': '/bin/bash', 11:42:26 INFO - 'SHLVL': '1', 11:42:26 INFO - 'TERM': 'linux', 11:42:26 INFO - 'TMOUT': '86400', 11:42:26 INFO - 'USER': 'cltbld', 11:42:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:26 INFO - '_': '/tools/buildbot/bin/python'} 11:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:26 INFO - Downloading/unpacking psutil>=0.7.1 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:42:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:27 INFO - Installing collected packages: psutil 11:42:27 INFO - Running setup.py install for psutil 11:42:27 INFO - building 'psutil._psutil_linux' extension 11:42:27 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 11:42:30 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 11:42:30 INFO - building 'psutil._psutil_posix' extension 11:42:30 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 11:42:30 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 11:42:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:42:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:42:30 INFO - Successfully installed psutil 11:42:30 INFO - Cleaning up... 11:42:30 INFO - Return code: 0 11:42:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:42:30 INFO - Using env: {'DISPLAY': ':0', 11:42:30 INFO - 'HOME': '/home/cltbld', 11:42:30 INFO - 'LANG': 'en_US.UTF-8', 11:42:30 INFO - 'LANGUAGE': 'en_US:en', 11:42:30 INFO - 'LOGNAME': 'cltbld', 11:42:30 INFO - 'MAIL': '/var/mail/cltbld', 11:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:30 INFO - 'MOZ_NO_REMOTE': '1', 11:42:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:30 INFO - 'NO_EM_RESTART': '1', 11:42:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:30 INFO - 'PWD': '/builds/slave/test', 11:42:30 INFO - 'SHELL': '/bin/bash', 11:42:30 INFO - 'SHLVL': '1', 11:42:30 INFO - 'TERM': 'linux', 11:42:30 INFO - 'TMOUT': '86400', 11:42:30 INFO - 'USER': 'cltbld', 11:42:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:30 INFO - '_': '/tools/buildbot/bin/python'} 11:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:42:32 INFO - Installing collected packages: mozsystemmonitor 11:42:32 INFO - Running setup.py install for mozsystemmonitor 11:42:32 INFO - Successfully installed mozsystemmonitor 11:42:32 INFO - Cleaning up... 11:42:32 INFO - Return code: 0 11:42:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:32 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 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:32 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 11:42:32 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 11:42:32 INFO - Using env: {'DISPLAY': ':0', 11:42:32 INFO - 'HOME': '/home/cltbld', 11:42:32 INFO - 'LANG': 'en_US.UTF-8', 11:42:32 INFO - 'LANGUAGE': 'en_US:en', 11:42:32 INFO - 'LOGNAME': 'cltbld', 11:42:32 INFO - 'MAIL': '/var/mail/cltbld', 11:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:32 INFO - 'MOZ_NO_REMOTE': '1', 11:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:32 INFO - 'NO_EM_RESTART': '1', 11:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:32 INFO - 'PWD': '/builds/slave/test', 11:42:32 INFO - 'SHELL': '/bin/bash', 11:42:32 INFO - 'SHLVL': '1', 11:42:32 INFO - 'TERM': 'linux', 11:42:32 INFO - 'TMOUT': '86400', 11:42:32 INFO - 'USER': 'cltbld', 11:42:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:32 INFO - '_': '/tools/buildbot/bin/python'} 11:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:33 INFO - Downloading/unpacking blobuploader==1.2.4 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:33 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 11:42:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:42:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:42:34 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 11:42:34 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 11:42:34 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 11:42:34 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 11:42:34 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 11:42:34 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 11:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:42:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:42:35 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 11:42:35 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 11:42:35 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 11:42:35 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 11:42:35 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 11:42:35 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 11:42:35 INFO - Downloading docopt-0.6.1.tar.gz 11:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:42:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:42:35 INFO - Running setup.py install for blobuploader 11:42:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:42:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:42:35 INFO - Running setup.py install for requests 11:42:36 INFO - Running setup.py install for docopt 11:42:36 INFO - Successfully installed blobuploader requests docopt 11:42:36 INFO - Cleaning up... 11:42:36 INFO - Return code: 0 11:42:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:36 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 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:36 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 11:42:36 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 11:42:36 INFO - Using env: {'DISPLAY': ':0', 11:42:36 INFO - 'HOME': '/home/cltbld', 11:42:36 INFO - 'LANG': 'en_US.UTF-8', 11:42:36 INFO - 'LANGUAGE': 'en_US:en', 11:42:36 INFO - 'LOGNAME': 'cltbld', 11:42:36 INFO - 'MAIL': '/var/mail/cltbld', 11:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:36 INFO - 'MOZ_NO_REMOTE': '1', 11:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:36 INFO - 'NO_EM_RESTART': '1', 11:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:36 INFO - 'PWD': '/builds/slave/test', 11:42:36 INFO - 'SHELL': '/bin/bash', 11:42:36 INFO - 'SHLVL': '1', 11:42:36 INFO - 'TERM': 'linux', 11:42:36 INFO - 'TMOUT': '86400', 11:42:36 INFO - 'USER': 'cltbld', 11:42:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:36 INFO - '_': '/tools/buildbot/bin/python'} 11:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:36 INFO - Running setup.py (path:/tmp/pip-Q6x5wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:36 INFO - Running setup.py (path:/tmp/pip-Qvjn01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:36 INFO - Running setup.py (path:/tmp/pip-pL1rtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:36 INFO - Running setup.py (path:/tmp/pip-GDfw0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:36 INFO - Running setup.py (path:/tmp/pip-CScTqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:36 INFO - Running setup.py (path:/tmp/pip-qJ3_TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:36 INFO - Running setup.py (path:/tmp/pip-vtkrsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:36 INFO - Running setup.py (path:/tmp/pip-Dmnjc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:37 INFO - Running setup.py (path:/tmp/pip-0pjH3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:37 INFO - Running setup.py (path:/tmp/pip-7CT0qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:37 INFO - Running setup.py (path:/tmp/pip-DwnQKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:37 INFO - Running setup.py (path:/tmp/pip-OtI7h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:37 INFO - Running setup.py (path:/tmp/pip-KJwQXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:37 INFO - Running setup.py (path:/tmp/pip-oe7oFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:37 INFO - Running setup.py (path:/tmp/pip-p21eMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:37 INFO - Running setup.py (path:/tmp/pip-63isiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:37 INFO - Running setup.py (path:/tmp/pip-Jk2LIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:42:37 INFO - Running setup.py install for manifestparser 11:42:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:42:37 INFO - Running setup.py install for mozcrash 11:42:37 INFO - Running setup.py install for mozdebug 11:42:37 INFO - Running setup.py install for mozdevice 11:42:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozfile 11:42:38 INFO - Running setup.py install for mozhttpd 11:42:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozinfo 11:42:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozInstall 11:42:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozleak 11:42:38 INFO - Running setup.py install for mozlog 11:42:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for moznetwork 11:42:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:42:38 INFO - Running setup.py install for mozprocess 11:42:38 INFO - Running setup.py install for mozprofile 11:42:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Running setup.py install for mozrunner 11:42:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Running setup.py install for mozscreenshot 11:42:39 INFO - Running setup.py install for moztest 11:42:39 INFO - Running setup.py install for mozversion 11:42:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:42:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:42:39 INFO - Cleaning up... 11:42:39 INFO - Return code: 0 11:42:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:39 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 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:39 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 11:42:39 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 11:42:39 INFO - Using env: {'DISPLAY': ':0', 11:42:39 INFO - 'HOME': '/home/cltbld', 11:42:39 INFO - 'LANG': 'en_US.UTF-8', 11:42:39 INFO - 'LANGUAGE': 'en_US:en', 11:42:39 INFO - 'LOGNAME': 'cltbld', 11:42:39 INFO - 'MAIL': '/var/mail/cltbld', 11:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:39 INFO - 'MOZ_NO_REMOTE': '1', 11:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:39 INFO - 'NO_EM_RESTART': '1', 11:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:39 INFO - 'PWD': '/builds/slave/test', 11:42:39 INFO - 'SHELL': '/bin/bash', 11:42:39 INFO - 'SHLVL': '1', 11:42:39 INFO - 'TERM': 'linux', 11:42:39 INFO - 'TMOUT': '86400', 11:42:39 INFO - 'USER': 'cltbld', 11:42:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:39 INFO - '_': '/tools/buildbot/bin/python'} 11:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:42:39 INFO - Running setup.py (path:/tmp/pip-3joVwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:42:39 INFO - Running setup.py (path:/tmp/pip-ask78H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:42:39 INFO - Running setup.py (path:/tmp/pip-r9PinS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:42:39 INFO - Running setup.py (path:/tmp/pip-UG1yvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:42:39 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)) 11:42:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:42:39 INFO - Running setup.py (path:/tmp/pip-K7f_4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:42:40 INFO - Running setup.py (path:/tmp/pip-ukfic_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:42:40 INFO - Running setup.py (path:/tmp/pip-yjwMK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:42:40 INFO - Running setup.py (path:/tmp/pip-DB7Uxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:42:40 INFO - Running setup.py (path:/tmp/pip-hmaz4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:42:40 INFO - Running setup.py (path:/tmp/pip-925Iy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:42:40 INFO - Running setup.py (path:/tmp/pip-5erzh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:42:40 INFO - Running setup.py (path:/tmp/pip-MFw7NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:42:40 INFO - Running setup.py (path:/tmp/pip-PzVb0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:42:40 INFO - Running setup.py (path:/tmp/pip-u5Ww6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:40 INFO - Running setup.py (path:/tmp/pip-Khss8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:42:40 INFO - Running setup.py (path:/tmp/pip-xUO3Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:42:40 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)) 11:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:42:40 INFO - Running setup.py (path:/tmp/pip-R9HSa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 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)) 11:42:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:42 INFO - Downloading blessings-1.6.tar.gz 11:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:42:42 INFO - Installing collected packages: blessings 11:42:42 INFO - Running setup.py install for blessings 11:42:43 INFO - Successfully installed blessings 11:42:43 INFO - Cleaning up... 11:42:43 INFO - Return code: 0 11:42:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:42:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:43 INFO - Reading from file tmpfile_stdout 11:42:43 INFO - Current package versions: 11:42:43 INFO - argparse == 1.2.1 11:42:43 INFO - blessings == 1.6 11:42:43 INFO - blobuploader == 1.2.4 11:42:43 INFO - docopt == 0.6.1 11:42:43 INFO - manifestparser == 1.1 11:42:43 INFO - mozInstall == 1.12 11:42:43 INFO - mozcrash == 0.17 11:42:43 INFO - mozdebug == 0.1 11:42:43 INFO - mozdevice == 0.48 11:42:43 INFO - mozfile == 1.2 11:42:43 INFO - mozhttpd == 0.7 11:42:43 INFO - mozinfo == 0.9 11:42:43 INFO - mozleak == 0.1 11:42:43 INFO - mozlog == 3.1 11:42:43 INFO - moznetwork == 0.27 11:42:43 INFO - mozprocess == 0.22 11:42:43 INFO - mozprofile == 0.28 11:42:43 INFO - mozrunner == 6.11 11:42:43 INFO - mozscreenshot == 0.1 11:42:43 INFO - mozsystemmonitor == 0.0 11:42:43 INFO - moztest == 0.7 11:42:43 INFO - mozversion == 1.4 11:42:43 INFO - psutil == 3.1.1 11:42:43 INFO - requests == 1.2.3 11:42:43 INFO - wsgiref == 0.1.2 11:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:42:43 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')]} 11:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:43 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')]} 11:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:43 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 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:43 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 11:42:43 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 11:42:43 INFO - Using env: {'DISPLAY': ':0', 11:42:43 INFO - 'HOME': '/home/cltbld', 11:42:43 INFO - 'LANG': 'en_US.UTF-8', 11:42:43 INFO - 'LANGUAGE': 'en_US:en', 11:42:43 INFO - 'LOGNAME': 'cltbld', 11:42:43 INFO - 'MAIL': '/var/mail/cltbld', 11:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:43 INFO - 'MOZ_NO_REMOTE': '1', 11:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:43 INFO - 'NO_EM_RESTART': '1', 11:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:43 INFO - 'PWD': '/builds/slave/test', 11:42:43 INFO - 'SHELL': '/bin/bash', 11:42:43 INFO - 'SHLVL': '1', 11:42:43 INFO - 'TERM': 'linux', 11:42:43 INFO - 'TMOUT': '86400', 11:42:43 INFO - 'USER': 'cltbld', 11:42:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:43 INFO - '_': '/tools/buildbot/bin/python'} 11:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 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)) 11:42:43 INFO - Cleaning up... 11:42:43 INFO - Return code: 0 11:42:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:42:43 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')]} 11:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:43 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')]} 11:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:43 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 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:43 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 11:42:43 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 11:42:43 INFO - Using env: {'DISPLAY': ':0', 11:42:43 INFO - 'HOME': '/home/cltbld', 11:42:43 INFO - 'LANG': 'en_US.UTF-8', 11:42:43 INFO - 'LANGUAGE': 'en_US:en', 11:42:43 INFO - 'LOGNAME': 'cltbld', 11:42:43 INFO - 'MAIL': '/var/mail/cltbld', 11:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:43 INFO - 'MOZ_NO_REMOTE': '1', 11:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:43 INFO - 'NO_EM_RESTART': '1', 11:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:43 INFO - 'PWD': '/builds/slave/test', 11:42:43 INFO - 'SHELL': '/bin/bash', 11:42:43 INFO - 'SHLVL': '1', 11:42:43 INFO - 'TERM': 'linux', 11:42:43 INFO - 'TMOUT': '86400', 11:42:43 INFO - 'USER': 'cltbld', 11:42:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:43 INFO - '_': '/tools/buildbot/bin/python'} 11:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:43 INFO - Downloading/unpacking jsonschema 11:42:43 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 11:42:43 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 11:42:43 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 11:42:43 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 11:42:43 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 11:42:43 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 11:42:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:42:45 INFO - Downloading/unpacking functools32 (from jsonschema) 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42: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 11:42:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:42:45 INFO - warning: no files found matching '*.txt' 11:42:45 INFO - no previously-included directories found matching 'build' 11:42:45 INFO - no previously-included directories found matching 'dist' 11:42:45 INFO - no previously-included directories found matching '.git*' 11:42:45 INFO - Installing collected packages: jsonschema, functools32 11:42:45 INFO - Running setup.py install for functools32 11:42:46 INFO - warning: no files found matching '*.txt' 11:42:46 INFO - no previously-included directories found matching 'build' 11:42:46 INFO - no previously-included directories found matching 'dist' 11:42:46 INFO - no previously-included directories found matching '.git*' 11:42:46 INFO - Successfully installed jsonschema functools32 11:42:46 INFO - Cleaning up... 11:42:46 INFO - Return code: 0 11:42:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd109613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', '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 11:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:42:46 INFO - Using env: {'DISPLAY': ':0', 11:42:46 INFO - 'HOME': '/home/cltbld', 11:42:46 INFO - 'LANG': 'en_US.UTF-8', 11:42:46 INFO - 'LANGUAGE': 'en_US:en', 11:42:46 INFO - 'LOGNAME': 'cltbld', 11:42:46 INFO - 'MAIL': '/var/mail/cltbld', 11:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:46 INFO - 'MOZ_NO_REMOTE': '1', 11:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:42:46 INFO - 'NO_EM_RESTART': '1', 11:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:46 INFO - 'PWD': '/builds/slave/test', 11:42:46 INFO - 'SHELL': '/bin/bash', 11:42:46 INFO - 'SHLVL': '1', 11:42:46 INFO - 'TERM': 'linux', 11:42:46 INFO - 'TMOUT': '86400', 11:42:46 INFO - 'USER': 'cltbld', 11:42:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:46 INFO - '_': '/tools/buildbot/bin/python'} 11:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:42:46 INFO - Downloading/unpacking flake8 11:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:42:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:42:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:42:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 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 11:42:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:42:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:48 INFO - no previously-included directories found matching 'docs/_build' 11:42:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:42:49 INFO - Running setup.py install for pep8 11:42:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:42:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:42:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:42:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:42:49 INFO - no previously-included directories found matching 'docs/_build' 11:42:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:42:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:42:49 INFO - Cleaning up... 11:42:49 INFO - Return code: 0 11:42:49 INFO - Running post-action listener: _resource_record_post_action 11:42:49 INFO - Running post-action listener: _start_resource_monitoring 11:42:49 INFO - Starting resource monitoring. 11:42:49 INFO - ##### 11:42:49 INFO - ##### Running install step. 11:42:49 INFO - ##### 11:42:49 INFO - Running pre-action listener: _resource_record_pre_action 11:42:49 INFO - Running main action method: install 11:42:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:42:49 INFO - Reading from file tmpfile_stdout 11:42:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:42:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:42:49 INFO - Reading from file tmpfile_stdout 11:42:49 INFO - Output received: 11:42:49 INFO - Usage: mozinstall [options] installer 11:42:49 INFO - Options: 11:42:49 INFO - -h, --help show this help message and exit 11:42:49 INFO - -d DEST, --destination=DEST 11:42:49 INFO - Directory to install application into. [default: 11:42:49 INFO - "/builds/slave/test"] 11:42:49 INFO - --app=APP Application being installed. [default: firefox] 11:42:49 INFO - mkdir: /builds/slave/test/build/application 11:42:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:43:06 INFO - Reading from file tmpfile_stdout 11:43:06 INFO - Output received: 11:43:06 INFO - /builds/slave/test/build/application/firefox/firefox 11:43:06 INFO - Running post-action listener: _resource_record_post_action 11:43:06 INFO - ##### 11:43:06 INFO - ##### Running run-tests step. 11:43:06 INFO - ##### 11:43:06 INFO - Running pre-action listener: _resource_record_pre_action 11:43:06 INFO - Running main action method: run_tests 11:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:43:06 INFO - Python 2.7.3 11:43:06 INFO - Return code: 0 11:43:06 INFO - grabbing minidump binary from tooltool 11:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:43:06 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 0x1197410>, '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 0x1198310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11987a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:43:06 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 11:43:06 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 11:43:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:43:06 INFO - Return code: 0 11:43:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:43:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:43:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:43:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:43:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:43:07 INFO - Return code: 0 11:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 11:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 11:43:07 INFO - Using env: {'DISPLAY': ':0', 11:43:07 INFO - 'HOME': '/home/cltbld', 11:43:07 INFO - 'LANG': 'en_US.UTF-8', 11:43:07 INFO - 'LANGUAGE': 'en_US:en', 11:43:07 INFO - 'LOGNAME': 'cltbld', 11:43:07 INFO - 'MAIL': '/var/mail/cltbld', 11:43:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:43:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:43:07 INFO - 'MOZ_NO_REMOTE': '1', 11:43:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:43:07 INFO - 'NO_EM_RESTART': '1', 11:43:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:43:07 INFO - 'PWD': '/builds/slave/test', 11:43:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:43:07 INFO - 'SHELL': '/bin/bash', 11:43:07 INFO - 'SHLVL': '1', 11:43:07 INFO - 'TERM': 'linux', 11:43:07 INFO - 'TMOUT': '86400', 11:43:07 INFO - 'USER': 'cltbld', 11:43:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571', 11:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:43:07 INFO - '_': '/tools/buildbot/bin/python'} 11:43:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 11:43:07 INFO - mozversion application_buildid: 20160505084822 11:43:07 INFO - mozversion application_changeset: ce2501a5f268283105549cc5316a35ca938c099f 11:43:07 INFO - mozversion application_display_name: Nightly 11:43:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:43:07 INFO - mozversion application_name: Firefox 11:43:07 INFO - mozversion application_remotingname: firefox 11:43:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:43:07 INFO - mozversion application_vendor: Mozilla 11:43:07 INFO - mozversion application_version: 49.0a1 11:43:07 INFO - mozversion platform_buildid: 20160505084822 11:43:07 INFO - mozversion platform_changeset: ce2501a5f268283105549cc5316a35ca938c099f 11:43:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:43:07 INFO - mozversion platform_version: 49.0a1 11:43:07 INFO - using testdate: 1462473787 11:43:07 INFO - actual date: 1462473787 11:43:07 INFO - starting webserver on 'localhost:58189' 11:43:07 INFO - SUITE-START | Running 2 tests 11:43:07 INFO - TEST-START | dromaeo_css 11:43:07 INFO - operating with platform_type : linux_ 11:43:07 INFO - Initialising browser for dromaeo_css test... 11:43:07 INFO - TEST-INFO | started process 3262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcs2OTC/profile http://localhost:58189/getInfo.html) 11:43:14 INFO - PROCESS | 3262 | 11:43:14 INFO - PROCESS | 3262 | (process:3331): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:15 INFO - PROCESS | 3262 | __metrics Screen width/height:1600/1200 11:43:15 INFO - PROCESS | 3262 | colorDepth:24 11:43:15 INFO - PROCESS | 3262 | Browser inner width/height: 1024/697 11:43:15 INFO - PROCESS | 3262 | __metrics 11:43:15 ERROR - PROCESS | 3262 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:43:16 INFO - TEST-INFO | 3262: exit 0 11:43:16 INFO - Browser initialized. 11:43:16 INFO - Running cycle 1/1 for dromaeo_css test... 11:43:16 INFO - TEST-INFO | started process 3382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcs2OTC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:18 INFO - PROCESS | 3382 | 11:43:18 INFO - PROCESS | 3382 | (process:3441): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:43:28 INFO - PROCESS | 3382 | RSS: Main: 164909056 11:43:28 INFO - PROCESS | 3382 | 11:44:18 INFO - PROCESS | 3382 | 1462473858193 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] 11:46:26 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:58189/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58189/tests/dromaeo/cssquery-ext.html) 11:46:27 INFO - PROCESS | 3382 | RSS: Main: 170967040 11:46:27 INFO - PROCESS | 3382 | 11:49:29 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:58189/tests/dromaeo/cssquery-ext.html (next: http://localhost:58189/tests/dromaeo/cssquery-jquery.html) 11:49:29 INFO - PROCESS | 3382 | RSS: Main: 166977536 11:49:29 INFO - PROCESS | 3382 | 11:52:31 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:58189/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58189/tests/dromaeo/cssquery-mootools.html) 11:52:32 INFO - PROCESS | 3382 | RSS: Main: 168538112 11:52:32 INFO - PROCESS | 3382 | 11:55:33 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:58189/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58189/tests/dromaeo/cssquery-prototype.html) 11:55:34 INFO - PROCESS | 3382 | RSS: Main: 166121472 11:55:34 INFO - PROCESS | 3382 | 11:58:36 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:58189/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58189/tests/dromaeo/cssquery-yui.html) 11:58:37 INFO - PROCESS | 3382 | RSS: Main: 166871040 11:58:37 INFO - PROCESS | 3382 | 12:01:39 INFO - PROCESS | 3382 | Cycle 1(1): loaded http://localhost:58189/tests/dromaeo/cssquery-yui.html (next: http://localhost:58189/tests/dromaeo/cssquery-dojo.html) 12:01:40 INFO - PROCESS | 3382 | RSS: Main: 169500672 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | __start_tp_report 12:01:40 INFO - PROCESS | 3382 | _x_x_mozilla_page_load 12:01:40 INFO - PROCESS | 3382 | _x_x_mozilla_page_load_details 12:01:40 INFO - PROCESS | 3382 | |i|pagename|runs| 12:01:40 INFO - PROCESS | 3382 | |0;dojo.html;3057.862396192171;3114.081346002929;3140.858661360238;3152.4325621388157;3159.0364938693688;5341.385740639823;5404.756785944632;5417.702026388547;5428.538574221196;5433.619646624733;5286.788528458857;5301.7084060376665;5401.43284955079;5402.297701298826;5414.729263536827;4811.615070794337;4825.951740482603;4876.341693871317;4890.755462226893;4963.553280204781;4784.138855006097;4959.156943319645;4991.101601711691;4994.900101997958;4996.5503104720565;4857.101436234308;4897.51024897511;4898.608111351101;4906.828261010865;4973.254011898208;4842.539958703917;4865.318855360252;4894.339264199359;4914.533119353691;4916.0905232532095;4779.900622856728;4881.438634557036;4883.096627123993;4900.436449808282;4920.065187614342;5188.948110518884;5220.582353411756;5305.8938821223355;5331.040412725708;5379.9731001345135;5668.659880407189;5680.829575112753;5700.9429905701245;5755.453231942959;5771.8557036074435;5674.858128546778;5767.077267637158;5792.218050563162;5804.071348584206;5810.21562089121;5244.134717771563;5417.891642167174;5449.891002179934;5501.477359650827;5519.172124181365;5791.681457519792;5821.970890145522;5843.065109582446;5873.911891321633;5886.0288052471715;5373.435789242151;5602.775888964477;5627.634203776824;5633.6619802811965;5634.014047541664;5672.97163514188;5753;5757.481826635623;5796.927568399859;5804.448577385142;5590;5658.179563963285;5781;5786.508146807484;5806.071028635398;5631.71841407928;5670.206171136044;5704.201411802351;5714.085746280575;5742.368339482654;4274.2092712848225;4346.891327716832;4353.891152721144;4390.297552391666;4398.692091553625;3851.826667799956;3861.478700375413;3864.0339915021245;3872.4191371294532;3900.7074469414906;5323.148296272655;5406.59450541211;5417.702026388586;5430.239766432703;5464.098423760035;5847.619904706181;5864.38423965486;5869.148973398833;5870.412958704181;5899.616524925866;5538.529225015919;5538.806141785019;5542.695151766691;5549.361823390281;5555.194496797942;4611.262198048296;4750.121227572841;4830.154722923475;4855.441624213261;4905.435874874363;6009;6014.428629280212;6024.939750602525;6026.9095963560585;6035.577509574376;5796.681182535001;5825.097109947965;5840.532757379315;5841.4450627190345;5853.326867410132;5826.82519524415;5861.3845546217035;5973.432523910222;6004.8799024020145;6023.879522409439;5560.4161563035295;5573.136163894441;5575.386707462095;5582.33012038558;5583.385827558884;5621.831345059655;5672.943270567242;5673.347565030074;5681.630694004876;5689.687067211343;5603.915941260802;5696.943030569641;5706.258186435737;5723.255976723;5786.247787787561;5378.784848606012;5577.247071645276;5609.719514024364;5616.382197958303;5655.377908429987;5479.945200548103;5548.250986116984;5563.109902415594;5565.053940829987;5568.832935011957;5452.800383915533;5475.890482190413;5591.133374326986;5614.719264036864;5678.006348888845;5582.748776304995;5603.55171586264;5613.663180209201;5622.156676498558;5624.521915637217 12:01:40 INFO - PROCESS | 3382 | |1;ext.html;608.6774009774821;642.4667525953458;646.666966512246;655.5607742812315;671.848834012347;36033.819830900844;37913.24173516528;37977.62022379772;37988.43017354742;38018.80990595047;40805;41775.37336939941;41941.16117677645;42026.57973420265;42186.578134218726;8679.17547832955;8913.064128266536;8922.910770892306;8928;8930.419522731034;8701.912980870173;8703;8809;8815.867761983576;8818.603162857687;8695.56522173892;8766.474011559296;8767;8830.558472076402;8838.116188381175;8658.740237792845;8788.033316335199;8796.032436432019;8798.86801697975;8815.250703690193;8606.612702428405;8694.869576956351;8706.129387061306;8738.563071846382;8758.299336053164;28616.14151575456;38980.610193897985;39628.20743585141;39737.80131099355;39885.60114398848;3361.243720162968;3559.2347645256136;3616.4032934565766;3623.764455310423;3639.290338384016;27806.443871122465;28637.10382079586;28731.28171795701;29085.854570727224;29723.256918576993;4190.413342132104;4267.445232119836;4273.7008409411355;4286.742795432253;4295.355696645528;216659;219496;219574;220905;221617.89191054102;33214;33750;51655;52208;52310.21534676983;34547.82726086354;34669.826650866584;34679.479807802905;34834.129146771535;34852.30295394078;14806.1856597886;14911.179885106207;15025.248737563079;15032;15072.924635376752;12970.416331265116;12983.610491685264;13044.673883152996;13047.825695687245;13057.412416441282;8359.916400836035;8535.317174626016;8565.700200493078;8603.31173506118;8619.233057223255;3302.240484688535;3323.11937336606;3356.7985920844826;3363.360961417323;3383.052745231339;1018.4449475036123;1090.2967585907045;1128.7065363005513;1141.7145713571608;1208.371646743706;31348;31533.36933261322;31810.840945795586;32202.35595288128;33346.66653333484;1180.262336039975;1190.696372425026;1211.9637709758206;1219.743853790714;1281.794912813964;16957.660846782994;16987.320507179575;17215.311387544607;17294.308227671005;17513.649727005388;302363;310910;311166;312121;494048;57682.71158644264;58534.41465585375;58601;58857;59050.40949590535;1442.4662874736205;1455.8180227471566;1474.6903150338549;1480.6076389756722;1497.9475718349806;31029.224269392544;32068.51897221497;32209.194770130933;32392.83803580967;32463.67536324701;48247.5175248243;49079.26381104215;49125.50874491209;49139.26291105708;49145.50854491409;422364;427246;427721;428553;429904;28287.575686365133;28304;28318.43363132767;28416;28494.85752571224;45536.884757477674;45625.54374456213;45975.77012114918;46334.768326158155;46856;38647.42028869513;39420;39569.406458903715;40013.599864000986;40478;38717.806410967765;38898.80550597229;39617.60382396139;40118.799406002785;40439.19121617492;37408.81295593505;37504.43743343907;38034;38050;39817.20365592614;32958.67041329556;35312.82343588266;35475;35520.64479355277;35601.643983559836;27722;28017.71982280151;28125.437491250468;28556.714432855406;28589 12:01:40 INFO - PROCESS | 3382 | |2;jquery.html;399.5225705282187;401.69270508061334;403.95960403959606;409.5331322292585;414.9917001659967;13803.585892423218;18019;18652.253909843606;18751.718724219114;18765.624687506257;17375.47873563792;17429.21568529416;17847.91076044618;18537;18614.720779188323;5264.6051546134;5501.78960628662;5570.721463926808;5680.744366503517;5728.369879313273;5343.465653434645;5504.559635229172;5530.142827861688;5537.695426751527;5663.292088488939;5613.66318020918;5620.803271885485;5625.296837895263;5643.435656434344;5645.915311270334;6611.768588099418;6949.166100067973;6977.825554361131;7002.614856182908;7019.543729657581;6559.639219842907;6705.966470167618;6990.650467476606;7015.088038554955;7018.894716579255;23383.298501044996;23898.283051508482;24597;26195.214143575533;26216.0824371148;2348.2602980061397;2461.569225385568;2571.3443072016703;2651.5866784603245;2701.7433343832304;14554.563363099123;15061.397544098332;15143;15699.843001570067;15781.763273550905;1963.4894927318858;2014.597080583889;2129.968050479244;2278.3392816083315;2337.8480398774027;97323;101284.49357753238;101605.49197253966;102362;103627;17422.303107875545;17768.289268429377;17858.821411785717;18004.9099754503;18021.639567208582;31827.840860795546;32070.83964580162;32231.194220144214;32430.513542296885;32491.675083248865;9697.757556061155;10080.747981300527;10114.544845481823;10154.339967902062;10371.688849334532;8737.432066915757;8757.299416046828;8789.604467798836;8923.286137109015;9049;8836.381453298207;8908.643654253887;8949.642014319485;9015.59064561258;9087.36388452802;3412.6896909997263;3442.4836274559016;3516.771409858351;3550.520679708258;3568.429051351823;891.4205766251858;925.5557332480447;1005.1305620638095;1089.3518356577824;1119.6249256499002;17547.824521754876;18125.456236312933;18285.451436456926;18324.81675183258;18941.147648355858;1021.8365061590258;1042.1246153231323;1077.9974623600126;1084.5444913136503;1118.3066498770813;8904.243139333099;10499.317544359592;10577.9471102644;10579.576816927236;10613.310134841211;184654;184734.0763296175;185524;185723;310935;97635;101500.49249753704;103189.48405257925;105053;105239;1076.6608518316705;1079.4764539198482;1115.726646971497;1138.1520767028617;1143.9714007149887;16541.834581654028;16929;16997.320107195574;17097.914510427367;17446.825531744522;37919.241615168095;38873;39042.414363783995;39412.211755764154;40159.1968160641;51284;58059.41940580709;58400.70799645974;58590.70704646449;58678.706606466694;8258.710945116893;8618.138186181583;8703.086175951434;8705.47767133974;8719.782005449915;9313.860292095489;9708.174805141642;12938.870611294144;13323.533676321282;13463.528776492776;11810.822837657613;11844.348560829238;11975;12011.519539218334;12228;11102.44487775592;11328.716782080513;11423;11586.42067896585;11730.648080557597;11953.760924781629;12114.333711645944;12135.939320303341;12185.329806860353;12335.568255111028;8576.836448807933;8606;8608.741737747878;8684.261837743863;8737;11692.181547291608;11810.76378472443;11855;12020.278783273032;12137.696557585778 12:01:40 INFO - PROCESS | 3382 | |3;mootools.html;1518.3546992528177;1530.4413888930542;1662.9916850415746;1784.5271003184166;1819.3268490658468;7603.543787372748;8048.637811298491;8096.797580060502;8416.326693864492;8442.366822488315;8131.674733010673;8221.465604735688;8228.300594449463;8236.135205803394;8255.215754503328;2182.2798476502794;2219.25654905606;2223.1885361842974;2224.077008041661;2226.4100013496436;2199.3621849663577;2211.557688462306;2275.1581914691587;2281.634938409855;2283.4291427143216;2190.1567896359857;2191.5945550073207;2200.449887528118;2255.875926824024;2293.4610366563843;2141.271967531039;2143.8499305048654;2157.6871353653632;2172.1854304635763;2176.3579743975565;2190.4304880730965;2192.2217612747404;2234.5642599693065;2275.5448910218024;2283.8058765004994;8314.667413303461;8341;8378.371622128303;8404.789880252982;8429.367797415218;5019.272205530177;5220.190870415092;5234.319538459976;5260.658057226268;5261.789528418897;3146.2920842810186;3236.4821628539557;3341.6992470677756;3385.2213990782257;3391.7795343302605;1100.1748688483638;1102.597551893561;1145.8109411947019;1151.8272259161108;1173.23153334566;11421.942890285578;11477;11529.827052594217;11579.421028948518;11594.304341739522;4650.883727906829;4674.74288914113;4770.427548694179;4830.6135509159885;4832.226843704991;9798.853017204749;9829.066238707312;9831.705048848546;9835.508224588742;9871.60513579463;5194.039102766001;5194.831162988373;5210.895782084337;5216.7913283469;5265.947340526623;4315.1585440838735;4743.667943244009;4875.536824001714;4927.827526036644;4935.777889994959;3856.96143038566;3863.4784304118584;3930.0174956260935;3977.3039718049226;3986.142979259415;1286.7104901397297;1295.6501744528925;1300.7918733002675;1302.5961951794784;1309.5743883237794;868.2966796894409;933.0249888866151;995.865558149655;1003.7390278527489;1056.4084112896803;5624.3813180550105;5744.540436765049;5836.503897168704;5837.854053648693;5859.296884373903;1059.84632228328;1093.059968427152;1101.655979704759;1121.3552207480732;1135.273425007979;3937.1928754605237;3948.368261078214;3974.602539746002;4000.2199571083943;4050.918981620351;9451.858222126673;9933.106020458194;10010.949945250373;10047.64833230848;10095.596176152872;9869.703908882744;9973.351732137387;10014.198864091;10024.147947424404;10024.298299119138;7550.962245188849;7876.448648594544;7918.960405197937;7930.682772689143;8049.678012879536;5603.639868748918;5696.658200507983;5744.655320680772;5778.508826749605;5789.363170051207;8753.168448997336;8989.370744047854;9053.954730226571;9277.48973806447;9360.251179905456;9263.629454821732;9307.11582399671;9317.534123293673;9387.483688397204;9412.105849944244;6604.966975165094;7211.4230861532005;7402.407807375289;7411.592362419903;7550.584717840571;7750.534967901944;7901.407394445325;7904.6838126474295;7932.127465978853;7942.444028918151;7207.387372073433;7460.664270107966;7558.546487210785;7611.619419028915;7621.542707437571;7295.452841037049;7407.259274072765;7466.626668666654;7472.364848987897;7491.475596708178;6798.422134118655;6980.755673551402;6989.26612705679;7009.754658586925;7041.155061392666;4900.436449808318;4938.259261110862;5005.099082165245;5029.270755740324;5134.204198349262;5281.207818827206;5367.114426119802;5384.353877534721;5427.674339539641;5465.207544906046 12:01:40 INFO - PROCESS | 3382 | |4;prototype.html;332.47468998981594;333.47977155637204;340.83810190159676;345.12166536165466;347.65234765234766;5363.892722145564;5366.195070739391;5504.8348549543525;5580.637258578195;5584.687598414369;5502.642328248661;5532.75102620382;5532.834014979547;5535.363433205172;5540.252065971093;4302.569743025688;4335.393044973691;4335.609795118438;4339.913201735972;4361.847335343264;4131.607497287753;4272.444582204309;4277.144571085795;4352.608265256126;4374.49693285273;4227.978860105695;4232.217039847623;4234.364845273219;4250.851220207293;4269.722468039583;4224.366345048252;4250.787460626987;4263.4031235627035;4277.893052673677;4287.571242875719;3717.237966216919;3760.3419401604883;3773.019015056078;3780.697544196485;3786.3373909565717;5276.419593844674;5276.947230527684;5277.287566178555;5279.128943724281;5297.417284098746;4874.585660218886;4926.778294976734;4928.67963582366;4929.383827021622;4931.457539670633;5653.604247702621;5683.488486036235;5723.599348045638;5747.339056008529;5759.1937128802;4164.75011499311;4167.791610419497;4182.686298527592;4183.686223533247;4198.685098617585;6069.180660610849;6071.423214794631;6075.20781369497;6075.875962946825;6095.359987201325;4126.884202427208;4284.464441944757;4298.828046878152;4300.88177073963;4302.483701955785;4327.913441731211;4337.978310108492;4338.544452832407;4349.804258808361;4358.259095953696;4940.481249468826;4959.2809042688605;4967.82612608557;4967.950320496821;4980.5019498049905;5648.774049038075;5811.593188476766;5845.152452894392;5846.327672317738;5860.853478663067;1578.6132397562671;1578.9026626494476;1589.6343840916654;1589.8966567173097;1594.4932039222824;1066.1097983183972;1073.806714791345;1089.4334945828125;1091.061686949223;1092.088106431123;5974.685569174774;5984.850378740566;5993.880122397528;6025.0962355646125;6052.182955301066;6436.549441539048;6450.741970321134;6457.644829534421;6459.482021724891;6462.903056454157;5832.50423713989;5978.342382337939;6033.12519684652;6046.3349031606485;6050.122732203894;3395.8471868765964;3410.0451873475467;3422.743294252941;3430.2453460238708;3441.397755392796;6466.4503517201565;6537.705803238866;6539.673016349164;6612.768553100618;6618.271990081087;6505.577137486048;6515.022746587955;6535.248446428626;6546.70539825709;6571.211454625475;5880.323762767251;6143.692815359214;6584.6378449184795;6630.071789949411;6652.501062420241;5960.731767070405;5977.6114552553945;5987.850303742442;5999.950008748364;6021.217241758719;5892.646441213541;5927.347991720993;5935.9109613356695;5948.375420580776;5958.672273025025;5772;6027.879442411039;6167.599106058092;6185.8144255672405;6232.844178895564;4138.151678905877;4207.97896010518;4219.303814870512;4221.472315960505;4224.4930608327195;5952.464278214981;6033.155358249761;6039.396060393926;6040.7583696651645;6059.33347331802;5725.370209277059;5852.736626851887;5853.2976042875125;5855.765769369177;5925.229720136354;5868.735906884115;5882;5886.440788125121;5899.793507227227;5907.734151963258;5754.683492407958;5762.798302059407;5768.769249229984;5789.1605717171615;5829.8251052468495;5678.148277758204;5883.499317905839;5902.83849885838;5932.8813423732145;5938.317093534299;5722.17028530869;5744.253247077853;5765.682887441063;5806.983777838776;5867.20792692981 12:01:40 INFO - PROCESS | 3382 | |5;yui.html;762.5767698927096;795.9243871832174;841.0370126205495;883.4390162246973;902.075372742938;14374.856251437483;14881.330340134693;14960.326785294646;14965.476208332711;14973.251337433112;13953.93023034886;14011.159330440181;14048.227347495884;14062.929685351559;14085.788713169311;707.2750430808424;816.3958670583785;821.6138414944967;825.8885050518194;833.6123702478346;830.7050996896105;830.9210624990616;833.6123702478346;833.6165363932598;833.649867055835;870.751835726818;878.8681697745358;879.8592225243963;881.2817553693751;889.6975028490313;875.1030194051085;880.7357792662176;886.3529623374908;887.6183241206279;889.1419779912384;638.1671918146817;641.0608458608161;643.2827397451854;643.9291677915426;645.3288579876922;13557.186568805902;13590.456381744818;13633.318334083257;13641.658958526017;13674.384652690653;14327.283635818167;14506.129632221995;14514.201718905457;14566.417343306255;14575.344109515097;11345.37600431976;11486.597969071126;11500.539978400853;11545.191836571443;11791.64625061241;3799.2781371539595;3835.290471262825;3864.787436690981;3907.7069219808627;3995.960040399588;52150.47849521494;52920;53241;53731.731341343046;53973.460265397625;10146.188304935587;10423;10445.947770261251;10499.370037797757;10546.156307495383;16206;16462.094584797953;16499.422520211974;16509.33962641481;16536.6692666146;7490.138634057044;8454.408191426664;8511.531865747444;8649.66459056064;8688.044315125331;4456.242438785414;4486.259767138451;4516.277395616686;4523.638108951276;4664.95335046652;3327.085051610826;3406.42090844557;3413.0955296846355;3414.709749671306;3416.094734895205;646.8415238266655;648.2156590525423;649.1334069017914;650.7527139686889;650.847050943028;762.7787941497015;766.1495739728897;780.2626517940605;789.0846617923181;810.3436216664403;9915.702528924145;10293.588256469657;10327.380357178594;10345.948270258601;10420.478976051167;675.9252788066997;767.2583631161606;805.2350267246139;829.5934991853948;836.878582699186;4783.4499032611;4900.14247506692;4900.828471003498;5097.64316497849;5119.385673719177;67108.66445667838;68282.65858670675;70346;70463;70975;56602;57281;57870;58199;58748;52548.21177682338;53209.935801283755;53236.46763532315;53321.7333913328;53446;9582.90417095848;9583.65828783957;9614.90385096168;9661.661841835503;9704.272179586418;32770.344593107526;32787;33161.17097072592;33835.66164338325;34252.48621270733;45008;45253;45530;46525;46694.299585506924;12504.687382815138;12622.55821046259;12677.239365638092;12682.682932926382;12808.487660493476;13606.387712552762;13878.583642490741;14163.575092747235;14498.565043048726;15068.246587670354;12391.93804030974;12679.30263835461;12696.238225706487;12721.173123746927;13013;13843.307834608027;13874.306284685927;13908.582742517741;13912;14511.419543218153;11221.2145149842;12262.957020857035;12543.87456125427;12691.93654031724;14095.365708542935;10350.482475876026;10460.476976151314;10616.416097114732;10784.514696838503;10998;11308.095352371955;11371.658850234506;11389.202755807013;11419.885801141882;11423.314601123959 12:01:40 INFO - PROCESS | 3382 | __end_tp_report 12:01:40 INFO - PROCESS | 3382 | __start_cc_report 12:01:40 INFO - PROCESS | 3382 | _x_x_mozilla_cycle_collect,350 12:01:40 INFO - PROCESS | 3382 | __end_cc_report 12:01:40 INFO - PROCESS | 3382 | __startTimestamp1462474900115__endTimestamp 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | ------- Summary: start ------- 12:01:40 INFO - PROCESS | 3382 | Number of tests: 6 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | [#0] dojo.html Cycles:165 Average:5334.06 Median:5563.11 stddev:615.61 (11.1%) stddev-sans-first:591.04 12:01:40 INFO - PROCESS | 3382 | Values: 3057.9 3114.1 3140.9 3152.4 3159.0 5341.4 5404.8 5417.7 5428.5 5433.6 5286.8 5301.7 5401.4 5402.3 5414.7 4811.6 4826.0 4876.3 4890.8 4963.6 4784.1 4959.2 4991.1 4994.9 4996.6 4857.1 4897.5 4898.6 4906.8 4973.3 4842.5 4865.3 4894.3 4914.5 4916.1 4779.9 4881.4 4883.1 4900.4 4920.1 5188.9 5220.6 5305.9 5331.0 5380.0 5668.7 5680.8 5700.9 5755.5 5771.9 5674.9 5767.1 5792.2 5804.1 5810.2 5244.1 5417.9 5449.9 5501.5 5519.2 5791.7 5822.0 5843.1 5873.9 5886.0 5373.4 5602.8 5627.6 5633.7 5634.0 5673.0 5753.0 5757.5 5796.9 5804.4 5590.0 5658.2 5781.0 5786.5 5806.1 5631.7 5670.2 5704.2 5714.1 5742.4 4274.2 4346.9 4353.9 4390.3 4398.7 3851.8 3861.5 3864.0 3872.4 3900.7 5323.1 5406.6 5417.7 5430.2 5464.1 5847.6 5864.4 5869.1 5870.4 5899.6 5538.5 5538.8 5542.7 5549.4 5555.2 4611.3 4750.1 4830.2 4855.4 4905.4 6009.0 6014.4 6024.9 6026.9 6035.6 5796.7 5825.1 5840.5 5841.4 5853.3 5826.8 5861.4 5973.4 6004.9 6023.9 5560.4 5573.1 5575.4 5582.3 5583.4 5621.8 5672.9 5673.3 5681.6 5689.7 5603.9 5696.9 5706.3 5723.3 5786.2 5378.8 5577.2 5609.7 5616.4 5655.4 5479.9 5548.3 5563.1 5565.1 5568.8 5452.8 5475.9 5591.1 5614.7 5678.0 5582.7 5603.6 5613.7 5622.2 5624.5 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | [#1] ext.html Cycles:180 Average:48820.41 Median:37945.43 stddev:91158.38 (240.2%) stddev-sans-first:91342.23 12:01:40 INFO - PROCESS | 3382 | Values: 608.7 642.5 646.7 655.6 671.8 36033.8 37913.2 37977.6 37988.4 38018.8 40805.0 41775.4 41941.2 42026.6 42186.6 8679.2 8913.1 8922.9 8928.0 8930.4 8701.9 8703.0 8809.0 8815.9 8818.6 8695.6 8766.5 8767.0 8830.6 8838.1 8658.7 8788.0 8796.0 8798.9 8815.3 8606.6 8694.9 8706.1 8738.6 8758.3 28616.1 38980.6 39628.2 39737.8 39885.6 3361.2 3559.2 3616.4 3623.8 3639.3 27806.4 28637.1 28731.3 29085.9 29723.3 4190.4 4267.4 4273.7 4286.7 4295.4 216659.0 219496.0 219574.0 220905.0 221617.9 33214.0 33750.0 51655.0 52208.0 52310.2 34547.8 34669.8 34679.5 34834.1 34852.3 14806.2 14911.2 15025.2 15032.0 15072.9 12970.4 12983.6 13044.7 13047.8 13057.4 8359.9 8535.3 8565.7 8603.3 8619.2 3302.2 3323.1 3356.8 3363.4 3383.1 1018.4 1090.3 1128.7 1141.7 1208.4 31348.0 31533.4 31810.8 32202.4 33346.7 1180.3 1190.7 1212.0 1219.7 1281.8 16957.7 16987.3 17215.3 17294.3 17513.6 302363.0 310910.0 311166.0 312121.0 494048.0 57682.7 58534.4 58601.0 58857.0 59050.4 1442.5 1455.8 1474.7 1480.6 1497.9 31029.2 32068.5 32209.2 32392.8 32463.7 48247.5 49079.3 49125.5 49139.3 49145.5 422364.0 427246.0 427721.0 428553.0 429904.0 28287.6 28304.0 28318.4 28416.0 28494.9 45536.9 45625.5 45975.8 46334.8 46856.0 38647.4 39420.0 39569.4 40013.6 40478.0 38717.8 38898.8 39617.6 40118.8 40439.2 37408.8 37504.4 38034.0 38050.0 39817.2 32958.7 35312.8 35475.0 35520.6 35601.6 27722.0 28017.7 28125.4 28556.7 28589.0 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | [#2] jquery.html Cycles:180 Average:22997.95 Median:12860.57 stddev:40313.18 (313.5%) stddev-sans-first:40390.56 12:01:40 INFO - PROCESS | 3382 | Values: 399.5 401.7 404.0 409.5 415.0 13803.6 18019.0 18652.3 18751.7 18765.6 17375.5 17429.2 17847.9 18537.0 18614.7 5264.6 5501.8 5570.7 5680.7 5728.4 5343.5 5504.6 5530.1 5537.7 5663.3 5613.7 5620.8 5625.3 5643.4 5645.9 6611.8 6949.2 6977.8 7002.6 7019.5 6559.6 6706.0 6990.7 7015.1 7018.9 23383.3 23898.3 24597.0 26195.2 26216.1 2348.3 2461.6 2571.3 2651.6 2701.7 14554.6 15061.4 15143.0 15699.8 15781.8 1963.5 2014.6 2130.0 2278.3 2337.8 97323.0 101284.5 101605.5 102362.0 103627.0 17422.3 17768.3 17858.8 18004.9 18021.6 31827.8 32070.8 32231.2 32430.5 32491.7 9697.8 10080.7 10114.5 10154.3 10371.7 8737.4 8757.3 8789.6 8923.3 9049.0 8836.4 8908.6 8949.6 9015.6 9087.4 3412.7 3442.5 3516.8 3550.5 3568.4 891.4 925.6 1005.1 1089.4 1119.6 17547.8 18125.5 18285.5 18324.8 18941.1 1021.8 1042.1 1078.0 1084.5 1118.3 8904.2 10499.3 10577.9 10579.6 10613.3 184654.0 184734.1 185524.0 185723.0 310935.0 97635.0 101500.5 103189.5 105053.0 105239.0 1076.7 1079.5 1115.7 1138.2 1144.0 16541.8 16929.0 16997.3 17097.9 17446.8 37919.2 38873.0 39042.4 39412.2 40159.2 51284.0 58059.4 58400.7 58590.7 58678.7 8258.7 8618.1 8703.1 8705.5 8719.8 9313.9 9708.2 12938.9 13323.5 13463.5 11810.8 11844.3 11975.0 12011.5 12228.0 11102.4 11328.7 11423.0 11586.4 11730.6 11953.8 12114.3 12135.9 12185.3 12335.6 8576.8 8606.0 8608.7 8684.3 8737.0 11692.2 11810.8 11855.0 12020.3 12137.7 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | [#3] mootools.html Cycles:180 Average:5542.36 Median:5202.86 stddev:3016.13 (58.0%) stddev-sans-first:3009.43 12:01:40 INFO - PROCESS | 3382 | Values: 1518.4 1530.4 1663.0 1784.5 1819.3 7603.5 8048.6 8096.8 8416.3 8442.4 8131.7 8221.5 8228.3 8236.1 8255.2 2182.3 2219.3 2223.2 2224.1 2226.4 2199.4 2211.6 2275.2 2281.6 2283.4 2190.2 2191.6 2200.4 2255.9 2293.5 2141.3 2143.8 2157.7 2172.2 2176.4 2190.4 2192.2 2234.6 2275.5 2283.8 8314.7 8341.0 8378.4 8404.8 8429.4 5019.3 5220.2 5234.3 5260.7 5261.8 3146.3 3236.5 3341.7 3385.2 3391.8 1100.2 1102.6 1145.8 1151.8 1173.2 11421.9 11477.0 11529.8 11579.4 11594.3 4650.9 4674.7 4770.4 4830.6 4832.2 9798.9 9829.1 9831.7 9835.5 9871.6 5194.0 5194.8 5210.9 5216.8 5265.9 4315.2 4743.7 4875.5 4927.8 4935.8 3857.0 3863.5 3930.0 3977.3 3986.1 1286.7 1295.7 1300.8 1302.6 1309.6 868.3 933.0 995.9 1003.7 1056.4 5624.4 5744.5 5836.5 5837.9 5859.3 1059.8 1093.1 1101.7 1121.4 1135.3 3937.2 3948.4 3974.6 4000.2 4050.9 9451.9 9933.1 10010.9 10047.6 10095.6 9869.7 9973.4 10014.2 10024.1 10024.3 7551.0 7876.4 7919.0 7930.7 8049.7 5603.6 5696.7 5744.7 5778.5 5789.4 8753.2 8989.4 9054.0 9277.5 9360.3 9263.6 9307.1 9317.5 9387.5 9412.1 6605.0 7211.4 7402.4 7411.6 7550.6 7750.5 7901.4 7904.7 7932.1 7942.4 7207.4 7460.7 7558.5 7611.6 7621.5 7295.5 7407.3 7466.6 7472.4 7491.5 6798.4 6980.8 6989.3 7009.8 7041.2 4900.4 4938.3 5005.1 5029.3 5134.2 5281.2 5367.1 5384.4 5427.7 5465.2 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | [#4] prototype.html Cycles:180 Average:4976.83 Median:5651.19 stddev:1480.71 (26.2%) stddev-sans-first:1443.25 12:01:40 INFO - PROCESS | 3382 | Values: 332.5 333.5 340.8 345.1 347.7 5363.9 5366.2 5504.8 5580.6 5584.7 5502.6 5532.8 5532.8 5535.4 5540.3 4302.6 4335.4 4335.6 4339.9 4361.8 4131.6 4272.4 4277.1 4352.6 4374.5 4228.0 4232.2 4234.4 4250.9 4269.7 4224.4 4250.8 4263.4 4277.9 4287.6 3717.2 3760.3 3773.0 3780.7 3786.3 5276.4 5276.9 5277.3 5279.1 5297.4 4874.6 4926.8 4928.7 4929.4 4931.5 5653.6 5683.5 5723.6 5747.3 5759.2 4164.8 4167.8 4182.7 4183.7 4198.7 6069.2 6071.4 6075.2 6075.9 6095.4 4126.9 4284.5 4298.8 4300.9 4302.5 4327.9 4338.0 4338.5 4349.8 4358.3 4940.5 4959.3 4967.8 4968.0 4980.5 5648.8 5811.6 5845.2 5846.3 5860.9 1578.6 1578.9 1589.6 1589.9 1594.5 1066.1 1073.8 1089.4 1091.1 1092.1 5974.7 5984.9 5993.9 6025.1 6052.2 6436.5 6450.7 6457.6 6459.5 6462.9 5832.5 5978.3 6033.1 6046.3 6050.1 3395.8 3410.0 3422.7 3430.2 3441.4 6466.5 6537.7 6539.7 6612.8 6618.3 6505.6 6515.0 6535.2 6546.7 6571.2 5880.3 6143.7 6584.6 6630.1 6652.5 5960.7 5977.6 5987.9 6000.0 6021.2 5892.6 5927.3 5935.9 5948.4 5958.7 5772.0 6027.9 6167.6 6185.8 6232.8 4138.2 4208.0 4219.3 4221.5 4224.5 5952.5 6033.2 6039.4 6040.8 6059.3 5725.4 5852.7 5853.3 5855.8 5925.2 5868.7 5882.0 5886.4 5899.8 5907.7 5754.7 5762.8 5768.8 5789.2 5829.8 5678.1 5883.5 5902.8 5932.9 5938.3 5722.2 5744.3 5765.7 5807.0 5867.2 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - PROCESS | 3382 | [#5] yui.html Cycles:180 Average:15232.47 Median:24747.13 stddev:17895.85 (72.3%) stddev-sans-first:17913.07 12:01:40 INFO - PROCESS | 3382 | Values: 762.6 795.9 841.0 883.4 902.1 14374.9 14881.3 14960.3 14965.5 14973.3 13953.9 14011.2 14048.2 14062.9 14085.8 707.3 816.4 821.6 825.9 833.6 830.7 830.9 833.6 833.6 833.6 870.8 878.9 879.9 881.3 889.7 875.1 880.7 886.4 887.6 889.1 638.2 641.1 643.3 643.9 645.3 13557.2 13590.5 13633.3 13641.7 13674.4 14327.3 14506.1 14514.2 14566.4 14575.3 11345.4 11486.6 11500.5 11545.2 11791.6 3799.3 3835.3 3864.8 3907.7 3996.0 52150.5 52920.0 53241.0 53731.7 53973.5 10146.2 10423.0 10445.9 10499.4 10546.2 16206.0 16462.1 16499.4 16509.3 16536.7 7490.1 8454.4 8511.5 8649.7 8688.0 4456.2 4486.3 4516.3 4523.6 4665.0 3327.1 3406.4 3413.1 3414.7 3416.1 646.8 648.2 649.1 650.8 650.8 762.8 766.1 780.3 789.1 810.3 9915.7 10293.6 10327.4 10345.9 10420.5 675.9 767.3 805.2 829.6 836.9 4783.4 4900.1 4900.8 5097.6 5119.4 67108.7 68282.7 70346.0 70463.0 70975.0 56602.0 57281.0 57870.0 58199.0 58748.0 52548.2 53209.9 53236.5 53321.7 53446.0 9582.9 9583.7 9614.9 9661.7 9704.3 32770.3 32787.0 33161.2 33835.7 34252.5 45008.0 45253.0 45530.0 46525.0 46694.3 12504.7 12622.6 12677.2 12682.7 12808.5 13606.4 13878.6 14163.6 14498.6 15068.2 12391.9 12679.3 12696.2 12721.2 13013.0 13843.3 13874.3 13908.6 13912.0 14511.4 11221.2 12263.0 12543.9 12691.9 14095.4 10350.5 10460.5 10616.4 10784.5 10998.0 11308.1 11371.7 11389.2 11419.9 11423.3 12:01:40 INFO - PROCESS | 3382 | -------- Summary: end -------- 12:01:40 INFO - PROCESS | 3382 | 12:01:40 INFO - TEST-INFO | 3382: exit 0 12:01:40 INFO - TEST-OK | dromaeo_css | took 1113096ms 12:01:40 INFO - TEST-START | kraken 12:01:40 INFO - operating with platform_type : linux_ 12:01:40 INFO - Initialising browser for kraken test... 12:01:40 INFO - TEST-INFO | started process 3613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYjm1A/profile http://localhost:58189/getInfo.html) 12:01:44 INFO - PROCESS | 3613 | 12:01:44 INFO - PROCESS | 3613 | (process:3680): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:45 INFO - PROCESS | 3613 | __metrics Screen width/height:1600/1200 12:01:45 INFO - PROCESS | 3613 | colorDepth:24 12:01:45 INFO - PROCESS | 3613 | Browser inner width/height: 1024/697 12:01:45 INFO - PROCESS | 3613 | __metrics 12:01:46 ERROR - PROCESS | 3613 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:01:47 INFO - TEST-INFO | 3613: exit 0 12:01:47 INFO - Browser initialized. 12:01:47 INFO - Running cycle 1/1 for kraken test... 12:01:47 INFO - TEST-INFO | started process 3731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYjm1A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:49 INFO - PROCESS | 3731 | 12:01:49 INFO - PROCESS | 3731 | (process:3794): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:01:59 INFO - PROCESS | 3731 | RSS: Main: 164151296 12:01:59 INFO - PROCESS | 3731 | 12:02:01 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58189/tests/kraken/driver.html?testName=audio-beat-detection) 12:02:02 INFO - PROCESS | 3731 | RSS: Main: 169246720 12:02:02 INFO - PROCESS | 3731 | 12:02:05 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58189/tests/kraken/driver.html?testName=audio-dft) 12:02:05 INFO - PROCESS | 3731 | RSS: Main: 171651072 12:02:05 INFO - PROCESS | 3731 | 12:02:08 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58189/tests/kraken/driver.html?testName=audio-fft) 12:02:09 INFO - PROCESS | 3731 | RSS: Main: 163368960 12:02:09 INFO - PROCESS | 3731 | 12:02:11 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58189/tests/kraken/driver.html?testName=audio-oscillator) 12:02:12 INFO - PROCESS | 3731 | RSS: Main: 163401728 12:02:12 INFO - PROCESS | 3731 | 12:02:14 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58189/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:02:15 INFO - PROCESS | 3731 | RSS: Main: 164741120 12:02:15 INFO - PROCESS | 3731 | 12:02:18 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58189/tests/kraken/driver.html?testName=imaging-darkroom) 12:02:18 INFO - PROCESS | 3731 | RSS: Main: 165564416 12:02:18 INFO - PROCESS | 3731 | 12:02:22 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58189/tests/kraken/driver.html?testName=imaging-desaturate) 12:02:22 INFO - PROCESS | 3731 | RSS: Main: 167825408 12:02:22 INFO - PROCESS | 3731 | 12:02:25 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58189/tests/kraken/driver.html?testName=json-parse-financial) 12:02:26 INFO - PROCESS | 3731 | RSS: Main: 168312832 12:02:26 INFO - PROCESS | 3731 | 12:02:27 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58189/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:02:28 INFO - PROCESS | 3731 | RSS: Main: 168177664 12:02:28 INFO - PROCESS | 3731 | 12:02:30 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:02:30 INFO - PROCESS | 3731 | RSS: Main: 168222720 12:02:30 INFO - PROCESS | 3731 | 12:02:32 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:02:33 INFO - PROCESS | 3731 | RSS: Main: 167960576 12:02:33 INFO - PROCESS | 3731 | 12:02:36 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:02:36 INFO - PROCESS | 3731 | RSS: Main: 168280064 12:02:36 INFO - PROCESS | 3731 | 12:02:39 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:02:40 INFO - PROCESS | 3731 | RSS: Main: 168165376 12:02:40 INFO - PROCESS | 3731 | 12:02:41 INFO - PROCESS | 3731 | Cycle 1(1): loaded http://localhost:58189/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58189/tests/kraken/driver.html?testName=ai-astar) 12:02:42 INFO - PROCESS | 3731 | RSS: Main: 170106880 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | __start_tp_report 12:02:42 INFO - PROCESS | 3731 | _x_x_mozilla_page_load 12:02:42 INFO - PROCESS | 3731 | _x_x_mozilla_page_load_details 12:02:42 INFO - PROCESS | 3731 | |i|pagename|runs| 12:02:42 INFO - PROCESS | 3731 | |0;ai-astar;116;106;113;112;113;125;113;112;112;112 12:02:42 INFO - PROCESS | 3731 | |1;audio-beat-detection;169;128;154;180;133;155;172;130;195;132 12:02:42 INFO - PROCESS | 3731 | |2;audio-dft;161;162;161;162;162;164;174;160;165;162 12:02:42 INFO - PROCESS | 3731 | |3;audio-fft;81;73;74;169;73;76;76;77;156;73 12:02:42 INFO - PROCESS | 3731 | |4;audio-oscillator;94;98;143;94;92;92;146;93;93;144 12:02:42 INFO - PROCESS | 3731 | |5;imaging-gaussian-blur;117;118;118;117;118;117;119;120;118;117 12:02:42 INFO - PROCESS | 3731 | |6;imaging-darkroom;147;148;147;148;147;148;148;147;147;147 12:02:42 INFO - PROCESS | 3731 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;97;97 12:02:42 INFO - PROCESS | 3731 | |8;json-parse-financial;63;58;60;58;64;61;62;73;55;60 12:02:42 INFO - PROCESS | 3731 | |9;json-stringify-tinderbox;59;61;61;60;61;60;60;59;65;60 12:02:42 INFO - PROCESS | 3731 | |10;stanford-crypto-aes;80;76;77;80;79;79;78;77;78;79 12:02:42 INFO - PROCESS | 3731 | |11;stanford-crypto-ccm;124;125;136;124;132;125;125;124;156;142 12:02:42 INFO - PROCESS | 3731 | |12;stanford-crypto-pbkdf2;172;167;169;168;176;170;172;173;176;166 12:02:42 INFO - PROCESS | 3731 | |13;stanford-crypto-sha256-iterative;70;70;70;72;70;68;69;70;69;71 12:02:42 INFO - PROCESS | 3731 | __end_tp_report 12:02:42 INFO - PROCESS | 3731 | __start_cc_report 12:02:42 INFO - PROCESS | 3731 | _x_x_mozilla_cycle_collect,855 12:02:42 INFO - PROCESS | 3731 | __end_cc_report 12:02:42 INFO - PROCESS | 3731 | __startTimestamp1462474962099__endTimestamp 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | ------- Summary: start ------- 12:02:42 INFO - PROCESS | 3731 | Number of tests: 14 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:4.77 (4.2%) stddev-sans-first:4.96 12:02:42 INFO - PROCESS | 3731 | Values: 116.0 106.0 113.0 112.0 113.0 125.0 113.0 112.0 112.0 112.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:162.00 stddev:23.75 (14.7%) stddev-sans-first:24.63 12:02:42 INFO - PROCESS | 3731 | Values: 169.0 128.0 154.0 180.0 133.0 155.0 172.0 130.0 195.0 132.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.00 stddev:4.03 (2.5%) stddev-sans-first:4.19 12:02:42 INFO - PROCESS | 3731 | Values: 161.0 162.0 161.0 162.0 162.0 164.0 174.0 160.0 165.0 162.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:36.94 (49.3%) stddev-sans-first:38.94 12:02:42 INFO - PROCESS | 3731 | Values: 81.0 73.0 74.0 169.0 73.0 76.0 76.0 77.0 156.0 73.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:24.52 (26.4%) stddev-sans-first:25.41 12:02:42 INFO - PROCESS | 3731 | Values: 94.0 98.0 143.0 94.0 92.0 92.0 146.0 93.0 93.0 144.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 12:02:42 INFO - PROCESS | 3731 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 119.0 120.0 118.0 117.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:02:42 INFO - PROCESS | 3731 | Values: 147.0 148.0 147.0 148.0 147.0 148.0 148.0 147.0 147.0 147.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 12:02:42 INFO - PROCESS | 3731 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 97.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:61.50 stddev:4.86 (7.9%) stddev-sans-first:5.12 12:02:42 INFO - PROCESS | 3731 | Values: 63.0 58.0 60.0 58.0 64.0 61.0 62.0 73.0 55.0 60.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.50 stddev:1.71 (2.8%) stddev-sans-first:1.72 12:02:42 INFO - PROCESS | 3731 | Values: 59.0 61.0 61.0 60.0 61.0 60.0 60.0 59.0 65.0 60.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.00 stddev:1.34 (1.7%) stddev-sans-first:1.27 12:02:42 INFO - PROCESS | 3731 | Values: 80.0 76.0 77.0 80.0 79.0 79.0 78.0 77.0 78.0 79.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:128.50 stddev:10.68 (8.3%) stddev-sans-first:10.99 12:02:42 INFO - PROCESS | 3731 | Values: 124.0 125.0 136.0 124.0 132.0 125.0 125.0 124.0 156.0 142.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:172.00 stddev:3.51 (2.0%) stddev-sans-first:3.70 12:02:42 INFO - PROCESS | 3731 | Values: 172.0 167.0 169.0 168.0 176.0 170.0 172.0 173.0 176.0 166.0 12:02:42 INFO - PROCESS | 3731 | 12:02:42 INFO - PROCESS | 3731 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 12:02:42 INFO - PROCESS | 3731 | Values: 70.0 70.0 70.0 72.0 70.0 68.0 69.0 70.0 69.0 71.0 12:02:42 INFO - PROCESS | 3731 | -------- Summary: end -------- 12:02:42 INFO - PROCESS | 3731 | 12:02:43 INFO - TEST-INFO | 3731: exit 0 12:02:43 INFO - TEST-OK | kraken | took 62322ms 12:02:43 INFO - SUITE-END | took 1175s 12:02:43 INFO - Completed test suite (00:19:35) 12:02:43 INFO - javascript benchmark 12:02:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.862396192171, 3114.081346002929, 3140.858661360238, 3152.4325621388157, 3159.0364938693688, 5341.385740639823, 5404.756785944632, 5417.702026388547, 5428.538574221196, 5433.619646624733, 5286.788528458857, 5301.7084060376665, 5401.43284955079, 5402.297701298826, 5414.729263536827, 4811.615070794337, 4825.951740482603, 4876.341693871317, 4890.755462226893, 4963.553280204781, 4784.138855006097, 4959.156943319645, 4991.101601711691, 4994.900101997958, 4996.5503104720565, 4857.101436234308, 4897.51024897511, 4898.608111351101, 4906.828261010865, 4973.254011898208, 4842.539958703917, 4865.318855360252, 4894.339264199359, 4914.533119353691, 4916.0905232532095, 4779.900622856728, 4881.438634557036, 4883.096627123993, 4900.436449808282, 4920.065187614342, 5188.948110518884, 5220.582353411756, 5305.8938821223355, 5331.040412725708, 5379.9731001345135, 5668.659880407189, 5680.829575112753, 5700.9429905701245, 5755.453231942959, 5771.8557036074435, 5674.858128546778, 5767.077267637158, 5792.218050563162, 5804.071348584206, 5810.21562089121, 5244.134717771563, 5417.891642167174, 5449.891002179934, 5501.477359650827, 5519.172124181365, 5791.681457519792, 5821.970890145522, 5843.065109582446, 5873.911891321633, 5886.0288052471715, 5373.435789242151, 5602.775888964477, 5627.634203776824, 5633.6619802811965, 5634.014047541664, 5672.97163514188, 5753.0, 5757.481826635623, 5796.927568399859, 5804.448577385142, 5590.0, 5658.179563963285, 5781.0, 5786.508146807484, 5806.071028635398, 5631.71841407928, 5670.206171136044, 5704.201411802351, 5714.085746280575, 5742.368339482654, 4274.2092712848225, 4346.891327716832, 4353.891152721144, 4390.297552391666, 4398.692091553625, 3851.826667799956, 3861.478700375413, 3864.0339915021245, 3872.4191371294532, 3900.7074469414906, 5323.148296272655, 5406.59450541211, 5417.702026388586, 5430.239766432703, 5464.098423760035, 5847.619904706181, 5864.38423965486, 5869.148973398833, 5870.412958704181, 5899.616524925866, 5538.529225015919, 5538.806141785019, 5542.695151766691, 5549.361823390281, 5555.194496797942, 4611.262198048296, 4750.121227572841, 4830.154722923475, 4855.441624213261, 4905.435874874363, 6009.0, 6014.428629280212, 6024.939750602525, 6026.9095963560585, 6035.577509574376, 5796.681182535001, 5825.097109947965, 5840.532757379315, 5841.4450627190345, 5853.326867410132, 5826.82519524415, 5861.3845546217035, 5973.432523910222, 6004.8799024020145, 6023.879522409439, 5560.4161563035295, 5573.136163894441, 5575.386707462095, 5582.33012038558, 5583.385827558884, 5621.831345059655, 5672.943270567242, 5673.347565030074, 5681.630694004876, 5689.687067211343, 5603.915941260802, 5696.943030569641, 5706.258186435737, 5723.255976723, 5786.247787787561, 5378.784848606012, 5577.247071645276, 5609.719514024364, 5616.382197958303, 5655.377908429987, 5479.945200548103, 5548.250986116984, 5563.109902415594, 5565.053940829987, 5568.832935011957, 5452.800383915533, 5475.890482190413, 5591.133374326986, 5614.719264036864, 5678.006348888845, 5582.748776304995, 5603.55171586264, 5613.663180209201, 5622.156676498558, 5624.521915637217], "value": 5292.066360776465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.6774009774821, 642.4667525953458, 646.666966512246, 655.5607742812315, 671.848834012347, 36033.819830900844, 37913.24173516528, 37977.62022379772, 37988.43017354742, 38018.80990595047, 40805.0, 41775.37336939941, 41941.16117677645, 42026.57973420265, 42186.578134218726, 8679.17547832955, 8913.064128266536, 8922.910770892306, 8928.0, 8930.419522731034, 8701.912980870173, 8703.0, 8809.0, 8815.867761983576, 8818.603162857687, 8695.56522173892, 8766.474011559296, 8767.0, 8830.558472076402, 8838.116188381175, 8658.740237792845, 8788.033316335199, 8796.032436432019, 8798.86801697975, 8815.250703690193, 8606.612702428405, 8694.869576956351, 8706.129387061306, 8738.563071846382, 8758.299336053164, 28616.14151575456, 38980.610193897985, 39628.20743585141, 39737.80131099355, 39885.60114398848, 3361.243720162968, 3559.2347645256136, 3616.4032934565766, 3623.764455310423, 3639.290338384016, 27806.443871122465, 28637.10382079586, 28731.28171795701, 29085.854570727224, 29723.256918576993, 4190.413342132104, 4267.445232119836, 4273.7008409411355, 4286.742795432253, 4295.355696645528, 216659.0, 219496.0, 219574.0, 220905.0, 221617.89191054102, 33214.0, 33750.0, 51655.0, 52208.0, 52310.21534676983, 34547.82726086354, 34669.826650866584, 34679.479807802905, 34834.129146771535, 34852.30295394078, 14806.1856597886, 14911.179885106207, 15025.248737563079, 15032.0, 15072.924635376752, 12970.416331265116, 12983.610491685264, 13044.673883152996, 13047.825695687245, 13057.412416441282, 8359.916400836035, 8535.317174626016, 8565.700200493078, 8603.31173506118, 8619.233057223255, 3302.240484688535, 3323.11937336606, 3356.7985920844826, 3363.360961417323, 3383.052745231339, 1018.4449475036123, 1090.2967585907045, 1128.7065363005513, 1141.7145713571608, 1208.371646743706, 31348.0, 31533.36933261322, 31810.840945795586, 32202.35595288128, 33346.66653333484, 1180.262336039975, 1190.696372425026, 1211.9637709758206, 1219.743853790714, 1281.794912813964, 16957.660846782994, 16987.320507179575, 17215.311387544607, 17294.308227671005, 17513.649727005388, 302363.0, 310910.0, 311166.0, 312121.0, 494048.0, 57682.71158644264, 58534.41465585375, 58601.0, 58857.0, 59050.40949590535, 1442.4662874736205, 1455.8180227471566, 1474.6903150338549, 1480.6076389756722, 1497.9475718349806, 31029.224269392544, 32068.51897221497, 32209.194770130933, 32392.83803580967, 32463.67536324701, 48247.5175248243, 49079.26381104215, 49125.50874491209, 49139.26291105708, 49145.50854491409, 422364.0, 427246.0, 427721.0, 428553.0, 429904.0, 28287.575686365133, 28304.0, 28318.43363132767, 28416.0, 28494.85752571224, 45536.884757477674, 45625.54374456213, 45975.77012114918, 46334.768326158155, 46856.0, 38647.42028869513, 39420.0, 39569.406458903715, 40013.599864000986, 40478.0, 38717.806410967765, 38898.80550597229, 39617.60382396139, 40118.799406002785, 40439.19121617492, 37408.81295593505, 37504.43743343907, 38034.0, 38050.0, 39817.20365592614, 32958.67041329556, 35312.82343588266, 35475.0, 35520.64479355277, 35601.643983559836, 27722.0, 28017.71982280151, 28125.437491250468, 28556.714432855406, 28589.0], "value": 18100.105125697934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.5225705282187, 401.69270508061334, 403.95960403959606, 409.5331322292585, 414.9917001659967, 13803.585892423218, 18019.0, 18652.253909843606, 18751.718724219114, 18765.624687506257, 17375.47873563792, 17429.21568529416, 17847.91076044618, 18537.0, 18614.720779188323, 5264.6051546134, 5501.78960628662, 5570.721463926808, 5680.744366503517, 5728.369879313273, 5343.465653434645, 5504.559635229172, 5530.142827861688, 5537.695426751527, 5663.292088488939, 5613.66318020918, 5620.803271885485, 5625.296837895263, 5643.435656434344, 5645.915311270334, 6611.768588099418, 6949.166100067973, 6977.825554361131, 7002.614856182908, 7019.543729657581, 6559.639219842907, 6705.966470167618, 6990.650467476606, 7015.088038554955, 7018.894716579255, 23383.298501044996, 23898.283051508482, 24597.0, 26195.214143575533, 26216.0824371148, 2348.2602980061397, 2461.569225385568, 2571.3443072016703, 2651.5866784603245, 2701.7433343832304, 14554.563363099123, 15061.397544098332, 15143.0, 15699.843001570067, 15781.763273550905, 1963.4894927318858, 2014.597080583889, 2129.968050479244, 2278.3392816083315, 2337.8480398774027, 97323.0, 101284.49357753238, 101605.49197253966, 102362.0, 103627.0, 17422.303107875545, 17768.289268429377, 17858.821411785717, 18004.9099754503, 18021.639567208582, 31827.840860795546, 32070.83964580162, 32231.194220144214, 32430.513542296885, 32491.675083248865, 9697.757556061155, 10080.747981300527, 10114.544845481823, 10154.339967902062, 10371.688849334532, 8737.432066915757, 8757.299416046828, 8789.604467798836, 8923.286137109015, 9049.0, 8836.381453298207, 8908.643654253887, 8949.642014319485, 9015.59064561258, 9087.36388452802, 3412.6896909997263, 3442.4836274559016, 3516.771409858351, 3550.520679708258, 3568.429051351823, 891.4205766251858, 925.5557332480447, 1005.1305620638095, 1089.3518356577824, 1119.6249256499002, 17547.824521754876, 18125.456236312933, 18285.451436456926, 18324.81675183258, 18941.147648355858, 1021.8365061590258, 1042.1246153231323, 1077.9974623600126, 1084.5444913136503, 1118.3066498770813, 8904.243139333099, 10499.317544359592, 10577.9471102644, 10579.576816927236, 10613.310134841211, 184654.0, 184734.0763296175, 185524.0, 185723.0, 310935.0, 97635.0, 101500.49249753704, 103189.48405257925, 105053.0, 105239.0, 1076.6608518316705, 1079.4764539198482, 1115.726646971497, 1138.1520767028617, 1143.9714007149887, 16541.834581654028, 16929.0, 16997.320107195574, 17097.914510427367, 17446.825531744522, 37919.241615168095, 38873.0, 39042.414363783995, 39412.211755764154, 40159.1968160641, 51284.0, 58059.41940580709, 58400.70799645974, 58590.70704646449, 58678.706606466694, 8258.710945116893, 8618.138186181583, 8703.086175951434, 8705.47767133974, 8719.782005449915, 9313.860292095489, 9708.174805141642, 12938.870611294144, 13323.533676321282, 13463.528776492776, 11810.822837657613, 11844.348560829238, 11975.0, 12011.519539218334, 12228.0, 11102.44487775592, 11328.716782080513, 11423.0, 11586.42067896585, 11730.648080557597, 11953.760924781629, 12114.333711645944, 12135.939320303341, 12185.329806860353, 12335.568255111028, 8576.836448807933, 8606.0, 8608.741737747878, 8684.261837743863, 8737.0, 11692.181547291608, 11810.76378472443, 11855.0, 12020.278783273032, 12137.696557585778], "value": 10030.740985896491, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.3546992528177, 1530.4413888930542, 1662.9916850415746, 1784.5271003184166, 1819.3268490658468, 7603.543787372748, 8048.637811298491, 8096.797580060502, 8416.326693864492, 8442.366822488315, 8131.674733010673, 8221.465604735688, 8228.300594449463, 8236.135205803394, 8255.215754503328, 2182.2798476502794, 2219.25654905606, 2223.1885361842974, 2224.077008041661, 2226.4100013496436, 2199.3621849663577, 2211.557688462306, 2275.1581914691587, 2281.634938409855, 2283.4291427143216, 2190.1567896359857, 2191.5945550073207, 2200.449887528118, 2255.875926824024, 2293.4610366563843, 2141.271967531039, 2143.8499305048654, 2157.6871353653632, 2172.1854304635763, 2176.3579743975565, 2190.4304880730965, 2192.2217612747404, 2234.5642599693065, 2275.5448910218024, 2283.8058765004994, 8314.667413303461, 8341.0, 8378.371622128303, 8404.789880252982, 8429.367797415218, 5019.272205530177, 5220.190870415092, 5234.319538459976, 5260.658057226268, 5261.789528418897, 3146.2920842810186, 3236.4821628539557, 3341.6992470677756, 3385.2213990782257, 3391.7795343302605, 1100.1748688483638, 1102.597551893561, 1145.8109411947019, 1151.8272259161108, 1173.23153334566, 11421.942890285578, 11477.0, 11529.827052594217, 11579.421028948518, 11594.304341739522, 4650.883727906829, 4674.74288914113, 4770.427548694179, 4830.6135509159885, 4832.226843704991, 9798.853017204749, 9829.066238707312, 9831.705048848546, 9835.508224588742, 9871.60513579463, 5194.039102766001, 5194.831162988373, 5210.895782084337, 5216.7913283469, 5265.947340526623, 4315.1585440838735, 4743.667943244009, 4875.536824001714, 4927.827526036644, 4935.777889994959, 3856.96143038566, 3863.4784304118584, 3930.0174956260935, 3977.3039718049226, 3986.142979259415, 1286.7104901397297, 1295.6501744528925, 1300.7918733002675, 1302.5961951794784, 1309.5743883237794, 868.2966796894409, 933.0249888866151, 995.865558149655, 1003.7390278527489, 1056.4084112896803, 5624.3813180550105, 5744.540436765049, 5836.503897168704, 5837.854053648693, 5859.296884373903, 1059.84632228328, 1093.059968427152, 1101.655979704759, 1121.3552207480732, 1135.273425007979, 3937.1928754605237, 3948.368261078214, 3974.602539746002, 4000.2199571083943, 4050.918981620351, 9451.858222126673, 9933.106020458194, 10010.949945250373, 10047.64833230848, 10095.596176152872, 9869.703908882744, 9973.351732137387, 10014.198864091, 10024.147947424404, 10024.298299119138, 7550.962245188849, 7876.448648594544, 7918.960405197937, 7930.682772689143, 8049.678012879536, 5603.639868748918, 5696.658200507983, 5744.655320680772, 5778.508826749605, 5789.363170051207, 8753.168448997336, 8989.370744047854, 9053.954730226571, 9277.48973806447, 9360.251179905456, 9263.629454821732, 9307.11582399671, 9317.534123293673, 9387.483688397204, 9412.105849944244, 6604.966975165094, 7211.4230861532005, 7402.407807375289, 7411.592362419903, 7550.584717840571, 7750.534967901944, 7901.407394445325, 7904.6838126474295, 7932.127465978853, 7942.444028918151, 7207.387372073433, 7460.664270107966, 7558.546487210785, 7611.619419028915, 7621.542707437571, 7295.452841037049, 7407.259274072765, 7466.626668666654, 7472.364848987897, 7491.475596708178, 6798.422134118655, 6980.755673551402, 6989.26612705679, 7009.754658586925, 7041.155061392666, 4900.436449808318, 4938.259261110862, 5005.099082165245, 5029.270755740324, 5134.204198349262, 5281.207818827206, 5367.114426119802, 5384.353877534721, 5427.674339539641, 5465.207544906046], "value": 4514.005902092894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.47468998981594, 333.47977155637204, 340.83810190159676, 345.12166536165466, 347.65234765234766, 5363.892722145564, 5366.195070739391, 5504.8348549543525, 5580.637258578195, 5584.687598414369, 5502.642328248661, 5532.75102620382, 5532.834014979547, 5535.363433205172, 5540.252065971093, 4302.569743025688, 4335.393044973691, 4335.609795118438, 4339.913201735972, 4361.847335343264, 4131.607497287753, 4272.444582204309, 4277.144571085795, 4352.608265256126, 4374.49693285273, 4227.978860105695, 4232.217039847623, 4234.364845273219, 4250.851220207293, 4269.722468039583, 4224.366345048252, 4250.787460626987, 4263.4031235627035, 4277.893052673677, 4287.571242875719, 3717.237966216919, 3760.3419401604883, 3773.019015056078, 3780.697544196485, 3786.3373909565717, 5276.419593844674, 5276.947230527684, 5277.287566178555, 5279.128943724281, 5297.417284098746, 4874.585660218886, 4926.778294976734, 4928.67963582366, 4929.383827021622, 4931.457539670633, 5653.604247702621, 5683.488486036235, 5723.599348045638, 5747.339056008529, 5759.1937128802, 4164.75011499311, 4167.791610419497, 4182.686298527592, 4183.686223533247, 4198.685098617585, 6069.180660610849, 6071.423214794631, 6075.20781369497, 6075.875962946825, 6095.359987201325, 4126.884202427208, 4284.464441944757, 4298.828046878152, 4300.88177073963, 4302.483701955785, 4327.913441731211, 4337.978310108492, 4338.544452832407, 4349.804258808361, 4358.259095953696, 4940.481249468826, 4959.2809042688605, 4967.82612608557, 4967.950320496821, 4980.5019498049905, 5648.774049038075, 5811.593188476766, 5845.152452894392, 5846.327672317738, 5860.853478663067, 1578.6132397562671, 1578.9026626494476, 1589.6343840916654, 1589.8966567173097, 1594.4932039222824, 1066.1097983183972, 1073.806714791345, 1089.4334945828125, 1091.061686949223, 1092.088106431123, 5974.685569174774, 5984.850378740566, 5993.880122397528, 6025.0962355646125, 6052.182955301066, 6436.549441539048, 6450.741970321134, 6457.644829534421, 6459.482021724891, 6462.903056454157, 5832.50423713989, 5978.342382337939, 6033.12519684652, 6046.3349031606485, 6050.122732203894, 3395.8471868765964, 3410.0451873475467, 3422.743294252941, 3430.2453460238708, 3441.397755392796, 6466.4503517201565, 6537.705803238866, 6539.673016349164, 6612.768553100618, 6618.271990081087, 6505.577137486048, 6515.022746587955, 6535.248446428626, 6546.70539825709, 6571.211454625475, 5880.323762767251, 6143.692815359214, 6584.6378449184795, 6630.071789949411, 6652.501062420241, 5960.731767070405, 5977.6114552553945, 5987.850303742442, 5999.950008748364, 6021.217241758719, 5892.646441213541, 5927.347991720993, 5935.9109613356695, 5948.375420580776, 5958.672273025025, 5772.0, 6027.879442411039, 6167.599106058092, 6185.8144255672405, 6232.844178895564, 4138.151678905877, 4207.97896010518, 4219.303814870512, 4221.472315960505, 4224.4930608327195, 5952.464278214981, 6033.155358249761, 6039.396060393926, 6040.7583696651645, 6059.33347331802, 5725.370209277059, 5852.736626851887, 5853.2976042875125, 5855.765769369177, 5925.229720136354, 5868.735906884115, 5882.0, 5886.440788125121, 5899.793507227227, 5907.734151963258, 5754.683492407958, 5762.798302059407, 5768.769249229984, 5789.1605717171615, 5829.8251052468495, 5678.148277758204, 5883.499317905839, 5902.83849885838, 5932.8813423732145, 5938.317093534299, 5722.17028530869, 5744.253247077853, 5765.682887441063, 5806.983777838776, 5867.20792692981], "value": 4511.746930462366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.5767698927096, 795.9243871832174, 841.0370126205495, 883.4390162246973, 902.075372742938, 14374.856251437483, 14881.330340134693, 14960.326785294646, 14965.476208332711, 14973.251337433112, 13953.93023034886, 14011.159330440181, 14048.227347495884, 14062.929685351559, 14085.788713169311, 707.2750430808424, 816.3958670583785, 821.6138414944967, 825.8885050518194, 833.6123702478346, 830.7050996896105, 830.9210624990616, 833.6123702478346, 833.6165363932598, 833.649867055835, 870.751835726818, 878.8681697745358, 879.8592225243963, 881.2817553693751, 889.6975028490313, 875.1030194051085, 880.7357792662176, 886.3529623374908, 887.6183241206279, 889.1419779912384, 638.1671918146817, 641.0608458608161, 643.2827397451854, 643.9291677915426, 645.3288579876922, 13557.186568805902, 13590.456381744818, 13633.318334083257, 13641.658958526017, 13674.384652690653, 14327.283635818167, 14506.129632221995, 14514.201718905457, 14566.417343306255, 14575.344109515097, 11345.37600431976, 11486.597969071126, 11500.539978400853, 11545.191836571443, 11791.64625061241, 3799.2781371539595, 3835.290471262825, 3864.787436690981, 3907.7069219808627, 3995.960040399588, 52150.47849521494, 52920.0, 53241.0, 53731.731341343046, 53973.460265397625, 10146.188304935587, 10423.0, 10445.947770261251, 10499.370037797757, 10546.156307495383, 16206.0, 16462.094584797953, 16499.422520211974, 16509.33962641481, 16536.6692666146, 7490.138634057044, 8454.408191426664, 8511.531865747444, 8649.66459056064, 8688.044315125331, 4456.242438785414, 4486.259767138451, 4516.277395616686, 4523.638108951276, 4664.95335046652, 3327.085051610826, 3406.42090844557, 3413.0955296846355, 3414.709749671306, 3416.094734895205, 646.8415238266655, 648.2156590525423, 649.1334069017914, 650.7527139686889, 650.847050943028, 762.7787941497015, 766.1495739728897, 780.2626517940605, 789.0846617923181, 810.3436216664403, 9915.702528924145, 10293.588256469657, 10327.380357178594, 10345.948270258601, 10420.478976051167, 675.9252788066997, 767.2583631161606, 805.2350267246139, 829.5934991853948, 836.878582699186, 4783.4499032611, 4900.14247506692, 4900.828471003498, 5097.64316497849, 5119.385673719177, 67108.66445667838, 68282.65858670675, 70346.0, 70463.0, 70975.0, 56602.0, 57281.0, 57870.0, 58199.0, 58748.0, 52548.21177682338, 53209.935801283755, 53236.46763532315, 53321.7333913328, 53446.0, 9582.90417095848, 9583.65828783957, 9614.90385096168, 9661.661841835503, 9704.272179586418, 32770.344593107526, 32787.0, 33161.17097072592, 33835.66164338325, 34252.48621270733, 45008.0, 45253.0, 45530.0, 46525.0, 46694.299585506924, 12504.687382815138, 12622.55821046259, 12677.239365638092, 12682.682932926382, 12808.487660493476, 13606.387712552762, 13878.583642490741, 14163.575092747235, 14498.565043048726, 15068.246587670354, 12391.93804030974, 12679.30263835461, 12696.238225706487, 12721.173123746927, 13013.0, 13843.307834608027, 13874.306284685927, 13908.582742517741, 13912.0, 14511.419543218153, 11221.2145149842, 12262.957020857035, 12543.87456125427, 12691.93654031724, 14095.365708542935, 10350.482475876026, 10460.476976151314, 10616.416097114732, 10784.514696838503, 10998.0, 11308.095352371955, 11371.658850234506, 11389.202755807013, 11419.885801141882, 11423.314601123959], "value": 6933.001755919125, "unit": "score"}], "name": "dromaeo_css", "value": 7168.331546498657, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 106.0, 113.0, 112.0, 113.0, 125.0, 113.0, 112.0, 112.0, 112.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 128.0, 154.0, 180.0, 133.0, 155.0, 172.0, 130.0, 195.0, 132.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 164.0, 174.0, 160.0, 165.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 74.0, 169.0, 73.0, 76.0, 76.0, 77.0, 156.0, 73.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 143.0, 94.0, 92.0, 92.0, 146.0, 93.0, 93.0, 144.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 120.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 97.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 58.0, 60.0, 58.0, 64.0, 61.0, 62.0, 73.0, 55.0, 60.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 59.0, 65.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 77.0, 80.0, 79.0, 79.0, 78.0, 77.0, 78.0, 79.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 136.0, 124.0, 132.0, 125.0, 125.0, 124.0, 156.0, 142.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 169.0, 168.0, 176.0, 170.0, 172.0, 173.0, 176.0, 166.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 72.0, 70.0, 68.0, 69.0, 70.0, 69.0, 71.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1566.4, "alertThreshold": 2.0}]} 12:02:43 INFO - Return code: 0 12:02:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:02:43 ERROR - # TBPL SUCCESS # 12:02:43 INFO - Running post-action listener: _resource_record_post_action 12:02:43 INFO - Running post-run listener: _resource_record_post_run 12:02:44 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7794688; Write bytes: 365895680; Read time: 2204; Write time: 400164 12:02:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 21286912; Read time: 0; Write time: 42872 12:02:44 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6057984; Write bytes: 344608768; Read time: 2132; Write time: 357292 12:02:44 INFO - Running post-run listener: _upload_blobber_files 12:02:44 INFO - Blob upload gear active. 12:02:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:02:44 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 12:02:44 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:02:44 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:02:44 INFO - (blobuploader) - INFO - Open directory for files ... 12:02:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:02:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:45 INFO - (blobuploader) - INFO - Done attempting. 12:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:02:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:46 INFO - (blobuploader) - INFO - Done attempting. 12:02:46 INFO - (blobuploader) - INFO - Iteration through files over. 12:02:46 INFO - Return code: 0 12:02:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:02:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:02:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b61db5576d74421a0ad4201f359e17f125821e2a344e9e28fcab8537a150a4462aebd51e649fa534fa2aa182e58199db60221aed516fa9cf3dfd542493dcbf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7341da9a413cde1bbe34a1d5744f931a18f836ee7dc3d0f75e4dadfa3cd29b2219de4ae5b82d03d554c35a915c8ad8909d77428226560fba090e5ed178f2886a"} 12:02:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:02:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:02:46 INFO - Contents: 12:02:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b61db5576d74421a0ad4201f359e17f125821e2a344e9e28fcab8537a150a4462aebd51e649fa534fa2aa182e58199db60221aed516fa9cf3dfd542493dcbf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7341da9a413cde1bbe34a1d5744f931a18f836ee7dc3d0f75e4dadfa3cd29b2219de4ae5b82d03d554c35a915c8ad8909d77428226560fba090e5ed178f2886a"} 12:02:46 INFO - Running post-run listener: copy_logs_to_upload_dir 12:02:46 INFO - Copying logs to upload dir... 12:02:46 INFO - mkdir: /builds/slave/test/build/upload/logs 12:02:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.674699 ========= master_lag: 15.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-05-05 12:03:02.438863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 12:03:02.442226) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571 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/Fx-Team/sha512/3b61db5576d74421a0ad4201f359e17f125821e2a344e9e28fcab8537a150a4462aebd51e649fa534fa2aa182e58199db60221aed516fa9cf3dfd542493dcbf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7341da9a413cde1bbe34a1d5744f931a18f836ee7dc3d0f75e4dadfa3cd29b2219de4ae5b82d03d554c35a915c8ad8909d77428226560fba090e5ed178f2886a"} build_url:https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011205 build_url: 'https://queue.taskcluster.net/v1/task/cLxBdVGxTDKNyftb2Mn9_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b61db5576d74421a0ad4201f359e17f125821e2a344e9e28fcab8537a150a4462aebd51e649fa534fa2aa182e58199db60221aed516fa9cf3dfd542493dcbf6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7341da9a413cde1bbe34a1d5744f931a18f836ee7dc3d0f75e4dadfa3cd29b2219de4ae5b82d03d554c35a915c8ad8909d77428226560fba090e5ed178f2886a"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 12:03:02.555910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:03:02.556249) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1462473723.843062-1859334571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 12:03:02.572535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 12:03:02.572900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 12:03:02.573215) ========= ========= Total master_lag: 15.90 =========