builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1463549913.16 results: success (0) buildid: 20160517194042 builduid: 23fc05504c824147b62ddecbe7228729 revision: 8483a86bf6720032befd0866987adcfe6b12f03f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.160463) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.160916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.161233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.197521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.198078) ========= 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=62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 22:38:33-- 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% 51.3M=0s 2016-05-17 22:38:33 (51.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.369989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.370737) ========= 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=62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.051699 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.436359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:33.436883) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8483a86bf6720032befd0866987adcfe6b12f03f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8483a86bf6720032befd0866987adcfe6b12f03f --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=62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 22:38:33,510 truncating revision to first 12 chars 2016-05-17 22:38:33,510 Setting DEBUG logging. 2016-05-17 22:38:33,510 attempt 1/10 2016-05-17 22:38:33,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8483a86bf672?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 22:38:33,773 unpacking tar archive at: mozilla-beta-8483a86bf672/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584418 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:34.033819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:34.034158) ========= script_repo_revision: 8483a86bf6720032befd0866987adcfe6b12f03f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:34.034634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:34.034948) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 22:38:34.042321) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-17 22:38:34.042660) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:38:34 INFO - MultiFileLogger online at 20160517 22:38:34 in /builds/slave/test 22:38:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 22:38:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:38:34 INFO - {'append_to_log': False, 22:38:34 INFO - 'base_work_dir': '/builds/slave/test', 22:38:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:38:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:38:34 INFO - 'branch': 'Mozilla-Beta', 22:38:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:38:34 INFO - 'config_files': ('talos/linux_config.py',), 22:38:34 INFO - 'default_actions': ('clobber', 22:38:34 INFO - 'read-buildbot-config', 22:38:34 INFO - 'download-and-extract', 22:38:34 INFO - 'populate-webroot', 22:38:34 INFO - 'create-virtualenv', 22:38:34 INFO - 'install', 22:38:34 INFO - 'run-tests'), 22:38:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:38:34 INFO - 'download_minidump_stackwalk': True, 22:38:34 INFO - 'download_symbols': 'ondemand', 22:38:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:38:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:38:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:38:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:38:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:38:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:38:34 INFO - 'installer_path': 'installer.exe', 22:38:34 INFO - 'log_level': 'info', 22:38:34 INFO - 'log_name': 'talos', 22:38:34 INFO - 'log_to_console': True, 22:38:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:38:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:38:34 INFO - 'opt_config_files': (), 22:38:34 INFO - 'pip_index': False, 22:38:34 INFO - 'sps_profile': False, 22:38:34 INFO - 'sps_profile_interval': 0, 22:38:34 INFO - 'suite': 'dromaeojs-e10s', 22:38:34 INFO - 'system_bits': '32', 22:38:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:38:34 INFO - 'title': 'talos-linux64-ix-018', 22:38:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:38:34 INFO - 'use_talos_json': True, 22:38:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:38:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:38:34 INFO - 'work_dir': 'build'} 22:38:34 INFO - ##### 22:38:34 INFO - ##### Running clobber step. 22:38:34 INFO - ##### 22:38:34 INFO - Running pre-action listener: _resource_record_pre_action 22:38:34 INFO - Running main action method: clobber 22:38:34 INFO - rmtree: /builds/slave/test/build 22:38:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:38:38 INFO - Running post-action listener: _resource_record_post_action 22:38:38 INFO - ##### 22:38:38 INFO - ##### Running read-buildbot-config step. 22:38:38 INFO - ##### 22:38:38 INFO - Running pre-action listener: _resource_record_pre_action 22:38:38 INFO - Running main action method: read_buildbot_config 22:38:38 INFO - Using buildbot properties: 22:38:38 INFO - { 22:38:38 INFO - "project": "", 22:38:38 INFO - "product": "firefox", 22:38:38 INFO - "script_repo_revision": "production", 22:38:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 22:38:38 INFO - "repository": "", 22:38:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 22:38:38 INFO - "buildid": "20160517194042", 22:38:38 INFO - "pgo_build": "True", 22:38:38 INFO - "basedir": "/builds/slave/test", 22:38:38 INFO - "buildnumber": 110, 22:38:38 INFO - "slavename": "talos-linux64-ix-018", 22:38:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:38:38 INFO - "platform": "ubuntu64_hw", 22:38:38 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:38:38 INFO - "branch": "mozilla-beta", 22:38:38 INFO - "repo_path": "releases/mozilla-beta", 22:38:38 INFO - "revision": "8483a86bf6720032befd0866987adcfe6b12f03f", 22:38:38 INFO - "stage_platform": "linux64-pgo", 22:38:38 INFO - "builduid": "23fc05504c824147b62ddecbe7228729", 22:38:38 INFO - "slavebuilddir": "test" 22:38:38 INFO - } 22:38:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 22:38:38 INFO - Running post-action listener: _resource_record_post_action 22:38:38 INFO - ##### 22:38:38 INFO - ##### Running download-and-extract step. 22:38:38 INFO - ##### 22:38:38 INFO - Running pre-action listener: _resource_record_pre_action 22:38:38 INFO - Running main action method: download_and_extract 22:38:38 INFO - mkdir: /builds/slave/test/build/tests 22:38:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:38 INFO - https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:38:44 INFO - Downloaded 1412 bytes. 22:38:44 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 22:38:44 INFO - Using the following test package requirements: 22:38:44 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 22:38:44 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:38:44 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 22:38:44 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'jsshell-linux-x86_64.zip'], 22:38:44 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:38:44 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 22:38:44 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 22:38:44 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 22:38:44 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:38:44 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 22:38:44 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 22:38:44 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:38:44 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:38:44 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')]} 22:38:44 INFO - https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:38:51 INFO - Downloaded 23364815 bytes. 22:38:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:38:52 INFO - Return code: 0 22:38:52 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:38:52 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')]} 22:38:52 INFO - https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:38:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:38:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:38:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 22:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:38:55 INFO - Downloaded 23364815 bytes. 22:38:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:38:56 INFO - Return code: 0 22:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:56 INFO - https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:38:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 22:38:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 22:38:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 22:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:38:57 INFO - Downloaded 10845194 bytes. 22:38:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:38:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:38:57 INFO - Return code: 0 22:38:57 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')]} 22:38:57 INFO - https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:38:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:38:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:38:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:38:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:38:59 INFO - Downloaded 53795380 bytes. 22:38:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:38:59 INFO - mkdir: /builds/slave/test/properties 22:38:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:38:59 INFO - Writing to file /builds/slave/test/properties/build_url 22:38:59 INFO - Contents: 22:38:59 INFO - build_url:https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 22:38:59 INFO - Running post-action listener: _resource_record_post_action 22:38:59 INFO - Running post-action listener: set_extra_try_arguments 22:38:59 INFO - ##### 22:38:59 INFO - ##### Running populate-webroot step. 22:38:59 INFO - ##### 22:38:59 INFO - Running pre-action listener: _resource_record_pre_action 22:38:59 INFO - Running main action method: populate_webroot 22:38:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:38:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:38:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:38:59 INFO - '--tppagecycles', 22:38:59 INFO - '7'], 22:38:59 INFO - 'tests': ['tsvgm']}}, 22:38:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:38:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:38:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:38:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:38:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'tests': ['damp', 'tps']}, 22:38:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['damp', 'tps']}, 22:38:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:38:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:38:59 INFO - 'other': {'tests': ['a11yr', 22:38:59 INFO - 'ts_paint', 22:38:59 INFO - 'tpaint', 22:38:59 INFO - 'sessionrestore', 22:38:59 INFO - 'sessionrestore_no_auto_restore', 22:38:59 INFO - 'tabpaint']}, 22:38:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['a11yr', 22:38:59 INFO - 'ts_paint', 22:38:59 INFO - 'tpaint', 22:38:59 INFO - 'sessionrestore', 22:38:59 INFO - 'sessionrestore_no_auto_restore', 22:38:59 INFO - 'tabpaint']}, 22:38:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['a11yr', 22:38:59 INFO - 'ts_paint', 22:38:59 INFO - 'tpaint', 22:38:59 INFO - 'sessionrestore', 22:38:59 INFO - 'sessionrestore_no_auto_restore', 22:38:59 INFO - 'tabpaint']}, 22:38:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['a11yr', 22:38:59 INFO - 'ts_paint', 22:38:59 INFO - 'tpaint', 22:38:59 INFO - 'sessionrestore', 22:38:59 INFO - 'sessionrestore_no_auto_restore', 22:38:59 INFO - 'tabpaint']}, 22:38:59 INFO - 'other_l64': {'tests': ['a11yr', 22:38:59 INFO - 'ts_paint', 22:38:59 INFO - 'tpaint', 22:38:59 INFO - 'sessionrestore', 22:38:59 INFO - 'sessionrestore_no_auto_restore', 22:38:59 INFO - 'tabpaint']}, 22:38:59 INFO - 'other_nol64': {'tests': ['a11yr', 22:38:59 INFO - 'ts_paint', 22:38:59 INFO - 'tpaint', 22:38:59 INFO - 'sessionrestore', 22:38:59 INFO - 'sessionrestore_no_auto_restore', 22:38:59 INFO - 'tabpaint']}, 22:38:59 INFO - 'svgr': {'tests': ['tsvgx', 22:38:59 INFO - 'tsvgr_opacity', 22:38:59 INFO - 'tart', 22:38:59 INFO - 'tscrollx', 22:38:59 INFO - 'cart']}, 22:38:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['tsvgx', 22:38:59 INFO - 'tsvgr_opacity', 22:38:59 INFO - 'tart', 22:38:59 INFO - 'tscrollx', 22:38:59 INFO - 'cart']}, 22:38:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'tests': ['tp5o']}, 22:38:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'talos_options': ['--e10s'], 22:38:59 INFO - 'tests': ['tp5o']}, 22:38:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'talos_options': ['--xperf_path', 22:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:59 INFO - 'tests': ['tp5n']}, 22:38:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:59 INFO - 'talos_options': ['--e10s', 22:38:59 INFO - '--xperf_path', 22:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:59 INFO - 'tests': ['tp5n']}}, 22:38:59 INFO - 'talos.zip': {'path': '', 22:38:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:38:59 INFO - Running post-action listener: _resource_record_post_action 22:38:59 INFO - ##### 22:38:59 INFO - ##### Running create-virtualenv step. 22:38:59 INFO - ##### 22:38:59 INFO - Running pre-action listener: _resource_record_pre_action 22:38:59 INFO - Running main action method: create_virtualenv 22:38:59 INFO - Creating virtualenv /builds/slave/test/build/venv 22:38:59 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 22:38:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:39:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:39:00 INFO - Using real prefix '/usr' 22:39:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:39:02 INFO - Installing distribute.............................................................................................................................................................................................done. 22:39:04 INFO - Installing pip.................done. 22:39:04 INFO - Return code: 0 22:39:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:39:04 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')]} 22:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:04 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')]} 22:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:04 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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:04 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 22:39:04 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 22:39:04 INFO - Using env: {'DISPLAY': ':0', 22:39:04 INFO - 'HOME': '/home/cltbld', 22:39:04 INFO - 'LANG': 'en_US.UTF-8', 22:39:04 INFO - 'LANGUAGE': 'en_US:en', 22:39:04 INFO - 'LOGNAME': 'cltbld', 22:39:04 INFO - 'MAIL': '/var/mail/cltbld', 22:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:04 INFO - 'MOZ_NO_REMOTE': '1', 22:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:04 INFO - 'NO_EM_RESTART': '1', 22:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:04 INFO - 'PWD': '/builds/slave/test', 22:39:04 INFO - 'SHELL': '/bin/bash', 22:39:04 INFO - 'SHLVL': '1', 22:39:04 INFO - 'TERM': 'linux', 22:39:04 INFO - 'TMOUT': '86400', 22:39:04 INFO - 'USER': 'cltbld', 22:39:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:04 INFO - '_': '/tools/buildbot/bin/python'} 22:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:04 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 22:39:04 INFO - Cleaning up... 22:39:04 INFO - Return code: 0 22:39:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:39:04 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')]} 22:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:04 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')]} 22:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:04 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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:04 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 22:39:04 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 22:39:04 INFO - Using env: {'DISPLAY': ':0', 22:39:04 INFO - 'HOME': '/home/cltbld', 22:39:04 INFO - 'LANG': 'en_US.UTF-8', 22:39:04 INFO - 'LANGUAGE': 'en_US:en', 22:39:04 INFO - 'LOGNAME': 'cltbld', 22:39:04 INFO - 'MAIL': '/var/mail/cltbld', 22:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:04 INFO - 'MOZ_NO_REMOTE': '1', 22:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:04 INFO - 'NO_EM_RESTART': '1', 22:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:04 INFO - 'PWD': '/builds/slave/test', 22:39:04 INFO - 'SHELL': '/bin/bash', 22:39:04 INFO - 'SHLVL': '1', 22:39:04 INFO - 'TERM': 'linux', 22:39:04 INFO - 'TMOUT': '86400', 22:39:04 INFO - 'USER': 'cltbld', 22:39:04 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:04 INFO - '_': '/tools/buildbot/bin/python'} 22:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:04 INFO - Downloading/unpacking psutil>=0.7.1 22:39:04 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 22:39:04 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 22:39:04 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 22:39:04 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 22:39:04 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 22:39:04 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 22:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:39:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:39:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:39:06 INFO - Installing collected packages: psutil 22:39:06 INFO - Running setup.py install for psutil 22:39:07 INFO - building 'psutil._psutil_linux' extension 22:39:07 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 22:39:07 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 22:39:08 INFO - building 'psutil._psutil_posix' extension 22:39:08 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 22:39:08 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 22:39:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:39:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:39:08 INFO - Successfully installed psutil 22:39:08 INFO - Cleaning up... 22:39:08 INFO - Return code: 0 22:39:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:39:08 INFO - Using env: {'DISPLAY': ':0', 22:39:08 INFO - 'HOME': '/home/cltbld', 22:39:08 INFO - 'LANG': 'en_US.UTF-8', 22:39:08 INFO - 'LANGUAGE': 'en_US:en', 22:39:08 INFO - 'LOGNAME': 'cltbld', 22:39:08 INFO - 'MAIL': '/var/mail/cltbld', 22:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:08 INFO - 'MOZ_NO_REMOTE': '1', 22:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:08 INFO - 'NO_EM_RESTART': '1', 22:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:08 INFO - 'PWD': '/builds/slave/test', 22:39:08 INFO - 'SHELL': '/bin/bash', 22:39:08 INFO - 'SHLVL': '1', 22:39:08 INFO - 'TERM': 'linux', 22:39:08 INFO - 'TMOUT': '86400', 22:39:08 INFO - 'USER': 'cltbld', 22:39:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:08 INFO - '_': '/tools/buildbot/bin/python'} 22:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:39:10 INFO - Installing collected packages: mozsystemmonitor 22:39:10 INFO - Running setup.py install for mozsystemmonitor 22:39:10 INFO - Successfully installed mozsystemmonitor 22:39:10 INFO - Cleaning up... 22:39:10 INFO - Return code: 0 22:39:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:10 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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:10 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 22:39:10 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 22:39:10 INFO - Using env: {'DISPLAY': ':0', 22:39:10 INFO - 'HOME': '/home/cltbld', 22:39:10 INFO - 'LANG': 'en_US.UTF-8', 22:39:10 INFO - 'LANGUAGE': 'en_US:en', 22:39:10 INFO - 'LOGNAME': 'cltbld', 22:39:10 INFO - 'MAIL': '/var/mail/cltbld', 22:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:10 INFO - 'MOZ_NO_REMOTE': '1', 22:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:10 INFO - 'NO_EM_RESTART': '1', 22:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:10 INFO - 'PWD': '/builds/slave/test', 22:39:10 INFO - 'SHELL': '/bin/bash', 22:39:10 INFO - 'SHLVL': '1', 22:39:10 INFO - 'TERM': 'linux', 22:39:10 INFO - 'TMOUT': '86400', 22:39:10 INFO - 'USER': 'cltbld', 22:39:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:10 INFO - '_': '/tools/buildbot/bin/python'} 22:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:10 INFO - Downloading/unpacking blobuploader==1.2.4 22:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:12 INFO - Downloading blobuploader-1.2.4.tar.gz 22:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:39:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:39:12 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 22:39:12 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 22:39:12 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 22:39:12 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 22:39:12 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 22:39:12 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 22:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:39:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:13 INFO - Downloading docopt-0.6.1.tar.gz 22:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:39:13 INFO - Installing collected packages: blobuploader, requests, docopt 22:39:13 INFO - Running setup.py install for blobuploader 22:39:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:39:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:39:13 INFO - Running setup.py install for requests 22:39:13 INFO - Running setup.py install for docopt 22:39:14 INFO - Successfully installed blobuploader requests docopt 22:39:14 INFO - Cleaning up... 22:39:14 INFO - Return code: 0 22:39:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:14 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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:14 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 22:39:14 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 22:39:14 INFO - Using env: {'DISPLAY': ':0', 22:39:14 INFO - 'HOME': '/home/cltbld', 22:39:14 INFO - 'LANG': 'en_US.UTF-8', 22:39:14 INFO - 'LANGUAGE': 'en_US:en', 22:39:14 INFO - 'LOGNAME': 'cltbld', 22:39:14 INFO - 'MAIL': '/var/mail/cltbld', 22:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:14 INFO - 'MOZ_NO_REMOTE': '1', 22:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:14 INFO - 'NO_EM_RESTART': '1', 22:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:14 INFO - 'PWD': '/builds/slave/test', 22:39:14 INFO - 'SHELL': '/bin/bash', 22:39:14 INFO - 'SHLVL': '1', 22:39:14 INFO - 'TERM': 'linux', 22:39:14 INFO - 'TMOUT': '86400', 22:39:14 INFO - 'USER': 'cltbld', 22:39:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:14 INFO - '_': '/tools/buildbot/bin/python'} 22:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:39:14 INFO - Running setup.py (path:/tmp/pip-Tdi11_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:39:14 INFO - Running setup.py (path:/tmp/pip-60S7AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:39:14 INFO - Running setup.py (path:/tmp/pip-IPQbCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:39:14 INFO - Running setup.py (path:/tmp/pip-FlhuOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:39:14 INFO - Running setup.py (path:/tmp/pip-GZwvSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:39:14 INFO - Running setup.py (path:/tmp/pip-S8zthn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:39:14 INFO - Running setup.py (path:/tmp/pip-S1Idnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:39:14 INFO - Running setup.py (path:/tmp/pip-Zt_F7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:39:14 INFO - Running setup.py (path:/tmp/pip-ts21oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:39:14 INFO - Running setup.py (path:/tmp/pip-qL2wXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:39:15 INFO - Running setup.py (path:/tmp/pip-rYqxIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:39:15 INFO - Running setup.py (path:/tmp/pip-QaeLqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:39:15 INFO - Running setup.py (path:/tmp/pip-gxrPY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:39:15 INFO - Running setup.py (path:/tmp/pip-6U0tIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:15 INFO - Running setup.py (path:/tmp/pip-oEaMo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:39:15 INFO - Running setup.py (path:/tmp/pip-ewsmu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:39:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:39:15 INFO - Running setup.py (path:/tmp/pip-DshtA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:39:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:39:15 INFO - Running setup.py install for manifestparser 22:39:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:39:15 INFO - Running setup.py install for mozcrash 22:39:15 INFO - Running setup.py install for mozdebug 22:39:15 INFO - Running setup.py install for mozdevice 22:39:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:39:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:39:15 INFO - Running setup.py install for mozfile 22:39:16 INFO - Running setup.py install for mozhttpd 22:39:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Running setup.py install for mozinfo 22:39:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Running setup.py install for mozInstall 22:39:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Running setup.py install for mozleak 22:39:16 INFO - Running setup.py install for mozlog 22:39:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Running setup.py install for moznetwork 22:39:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Running setup.py install for mozprocess 22:39:16 INFO - Running setup.py install for mozprofile 22:39:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Running setup.py install for mozrunner 22:39:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:39:17 INFO - Running setup.py install for mozscreenshot 22:39:17 INFO - Running setup.py install for moztest 22:39:17 INFO - Running setup.py install for mozversion 22:39:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:39:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:39:17 INFO - Cleaning up... 22:39:17 INFO - Return code: 0 22:39:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:17 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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:17 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 22:39:17 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 22:39:17 INFO - Using env: {'DISPLAY': ':0', 22:39:17 INFO - 'HOME': '/home/cltbld', 22:39:17 INFO - 'LANG': 'en_US.UTF-8', 22:39:17 INFO - 'LANGUAGE': 'en_US:en', 22:39:17 INFO - 'LOGNAME': 'cltbld', 22:39:17 INFO - 'MAIL': '/var/mail/cltbld', 22:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:17 INFO - 'MOZ_NO_REMOTE': '1', 22:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:17 INFO - 'NO_EM_RESTART': '1', 22:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:17 INFO - 'PWD': '/builds/slave/test', 22:39:17 INFO - 'SHELL': '/bin/bash', 22:39:17 INFO - 'SHLVL': '1', 22:39:17 INFO - 'TERM': 'linux', 22:39:17 INFO - 'TMOUT': '86400', 22:39:17 INFO - 'USER': 'cltbld', 22:39:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:17 INFO - '_': '/tools/buildbot/bin/python'} 22:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:39:17 INFO - Running setup.py (path:/tmp/pip-6NHWQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:39:17 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)) 22:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:39:17 INFO - Running setup.py (path:/tmp/pip-JcMckM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:39:17 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)) 22:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:39:17 INFO - Running setup.py (path:/tmp/pip-TffmKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:39:17 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)) 22:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:39:17 INFO - Running setup.py (path:/tmp/pip-aS09Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:39:17 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)) 22:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:39:17 INFO - Running setup.py (path:/tmp/pip-lRaZ0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:39:17 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)) 22:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:39:17 INFO - Running setup.py (path:/tmp/pip-BH_gUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:39:17 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)) 22:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:39:17 INFO - Running setup.py (path:/tmp/pip-svcq_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:39:18 INFO - Running setup.py (path:/tmp/pip-KbAsqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:39:18 INFO - Running setup.py (path:/tmp/pip-noOXo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:39:18 INFO - Running setup.py (path:/tmp/pip-GhGLtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:39:18 INFO - Running setup.py (path:/tmp/pip-k5b404-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:39:18 INFO - Running setup.py (path:/tmp/pip-pV3tXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:39:18 INFO - Running setup.py (path:/tmp/pip-JbxosZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:39:18 INFO - Running setup.py (path:/tmp/pip-yVrswy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:18 INFO - Running setup.py (path:/tmp/pip-LDxUYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:39:18 INFO - Running setup.py (path:/tmp/pip-5wGksr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:39:18 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)) 22:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:39:18 INFO - Running setup.py (path:/tmp/pip-UH5CNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:39:18 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)) 22:39:18 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)) 22:39:18 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)) 22:39:18 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)) 22:39:18 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)) 22:39:18 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)) 22:39:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:20 INFO - Downloading blessings-1.6.tar.gz 22:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:39:20 INFO - Installing collected packages: blessings 22:39:20 INFO - Running setup.py install for blessings 22:39:20 INFO - Successfully installed blessings 22:39:20 INFO - Cleaning up... 22:39:20 INFO - Return code: 0 22:39:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:21 INFO - Reading from file tmpfile_stdout 22:39:21 INFO - Current package versions: 22:39:21 INFO - argparse == 1.2.1 22:39:21 INFO - blessings == 1.6 22:39:21 INFO - blobuploader == 1.2.4 22:39:21 INFO - docopt == 0.6.1 22:39:21 INFO - manifestparser == 1.1 22:39:21 INFO - mozInstall == 1.12 22:39:21 INFO - mozcrash == 0.17 22:39:21 INFO - mozdebug == 0.1 22:39:21 INFO - mozdevice == 0.48 22:39:21 INFO - mozfile == 1.2 22:39:21 INFO - mozhttpd == 0.7 22:39:21 INFO - mozinfo == 0.9 22:39:21 INFO - mozleak == 0.1 22:39:21 INFO - mozlog == 3.1 22:39:21 INFO - moznetwork == 0.27 22:39:21 INFO - mozprocess == 0.22 22:39:21 INFO - mozprofile == 0.28 22:39:21 INFO - mozrunner == 6.11 22:39:21 INFO - mozscreenshot == 0.1 22:39:21 INFO - mozsystemmonitor == 0.0 22:39:21 INFO - moztest == 0.7 22:39:21 INFO - mozversion == 1.4 22:39:21 INFO - psutil == 3.1.1 22:39:21 INFO - requests == 1.2.3 22:39:21 INFO - wsgiref == 0.1.2 22:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39:21 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')]} 22:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:21 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')]} 22:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:21 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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:21 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 22:39:21 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 22:39:21 INFO - Using env: {'DISPLAY': ':0', 22:39:21 INFO - 'HOME': '/home/cltbld', 22:39:21 INFO - 'LANG': 'en_US.UTF-8', 22:39:21 INFO - 'LANGUAGE': 'en_US:en', 22:39:21 INFO - 'LOGNAME': 'cltbld', 22:39:21 INFO - 'MAIL': '/var/mail/cltbld', 22:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:21 INFO - 'MOZ_NO_REMOTE': '1', 22:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:21 INFO - 'NO_EM_RESTART': '1', 22:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:21 INFO - 'PWD': '/builds/slave/test', 22:39:21 INFO - 'SHELL': '/bin/bash', 22:39:21 INFO - 'SHLVL': '1', 22:39:21 INFO - 'TERM': 'linux', 22:39:21 INFO - 'TMOUT': '86400', 22:39:21 INFO - 'USER': 'cltbld', 22:39:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:21 INFO - '_': '/tools/buildbot/bin/python'} 22:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 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)) 22:39:21 INFO - Cleaning up... 22:39:21 INFO - Return code: 0 22:39:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:39:21 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')]} 22:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:21 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')]} 22:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:21 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 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39:21 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 22:39:21 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 22:39:21 INFO - Using env: {'DISPLAY': ':0', 22:39:21 INFO - 'HOME': '/home/cltbld', 22:39:21 INFO - 'LANG': 'en_US.UTF-8', 22:39:21 INFO - 'LANGUAGE': 'en_US:en', 22:39:21 INFO - 'LOGNAME': 'cltbld', 22:39:21 INFO - 'MAIL': '/var/mail/cltbld', 22:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:21 INFO - 'MOZ_NO_REMOTE': '1', 22:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:21 INFO - 'NO_EM_RESTART': '1', 22:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:21 INFO - 'PWD': '/builds/slave/test', 22:39:21 INFO - 'SHELL': '/bin/bash', 22:39:21 INFO - 'SHLVL': '1', 22:39:21 INFO - 'TERM': 'linux', 22:39:21 INFO - 'TMOUT': '86400', 22:39:21 INFO - 'USER': 'cltbld', 22:39:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:21 INFO - '_': '/tools/buildbot/bin/python'} 22:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:21 INFO - Downloading/unpacking jsonschema 22:39:21 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 22:39:21 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 22:39:21 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 22:39:21 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 22:39:21 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 22:39:21 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 22:39:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:39:23 INFO - Downloading/unpacking functools32 (from jsonschema) 22:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:23 INFO - Downloading functools32-3.2.3-2.tar.gz 22:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:39:23 INFO - warning: no files found matching '*.txt' 22:39:23 INFO - no previously-included directories found matching 'build' 22:39:23 INFO - no previously-included directories found matching 'dist' 22:39:23 INFO - no previously-included directories found matching '.git*' 22:39:23 INFO - Installing collected packages: jsonschema, functools32 22:39:23 INFO - Running setup.py install for functools32 22:39:23 INFO - warning: no files found matching '*.txt' 22:39:23 INFO - no previously-included directories found matching 'build' 22:39:23 INFO - no previously-included directories found matching 'dist' 22:39:23 INFO - no previously-included directories found matching '.git*' 22:39:23 INFO - Successfully installed jsonschema functools32 22:39:23 INFO - Cleaning up... 22:39:23 INFO - Return code: 0 22:39:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16dcd37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf33410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, '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': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', '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 22:39: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', 'flake8'] in /builds/slave/test/build 22:39: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 flake8 22:39:23 INFO - Using env: {'DISPLAY': ':0', 22:39:23 INFO - 'HOME': '/home/cltbld', 22:39:23 INFO - 'LANG': 'en_US.UTF-8', 22:39:23 INFO - 'LANGUAGE': 'en_US:en', 22:39:23 INFO - 'LOGNAME': 'cltbld', 22:39:23 INFO - 'MAIL': '/var/mail/cltbld', 22:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:23 INFO - 'MOZ_NO_REMOTE': '1', 22:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:23 INFO - 'NO_EM_RESTART': '1', 22:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:23 INFO - 'PWD': '/builds/slave/test', 22:39:23 INFO - 'SHELL': '/bin/bash', 22:39:23 INFO - 'SHLVL': '1', 22:39:23 INFO - 'TERM': 'linux', 22:39:23 INFO - 'TMOUT': '86400', 22:39:23 INFO - 'USER': 'cltbld', 22:39:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:23 INFO - '_': '/tools/buildbot/bin/python'} 22:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:24 INFO - Downloading/unpacking flake8 22:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:39:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:39:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39: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 22:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:39:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:39:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:39:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:39:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:39:26 INFO - no previously-included directories found matching 'docs/_build' 22:39:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:39:26 INFO - Running setup.py install for pep8 22:39:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:39:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:39:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:39:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:39:26 INFO - no previously-included directories found matching 'docs/_build' 22:39:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:39:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:39:26 INFO - Cleaning up... 22:39:27 INFO - Return code: 0 22:39:27 INFO - Running post-action listener: _resource_record_post_action 22:39:27 INFO - Running post-action listener: _start_resource_monitoring 22:39:27 INFO - Starting resource monitoring. 22:39:27 INFO - ##### 22:39:27 INFO - ##### Running install step. 22:39:27 INFO - ##### 22:39:27 INFO - Running pre-action listener: _resource_record_pre_action 22:39:27 INFO - Running main action method: install 22:39:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:27 INFO - Reading from file tmpfile_stdout 22:39:27 INFO - Detecting whether we're running mozinstall >=1.0... 22:39:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:39:27 INFO - Reading from file tmpfile_stdout 22:39:27 INFO - Output received: 22:39:27 INFO - Usage: mozinstall [options] installer 22:39:27 INFO - Options: 22:39:27 INFO - -h, --help show this help message and exit 22:39:27 INFO - -d DEST, --destination=DEST 22:39:27 INFO - Directory to install application into. [default: 22:39:27 INFO - "/builds/slave/test"] 22:39:27 INFO - --app=APP Application being installed. [default: firefox] 22:39:27 INFO - mkdir: /builds/slave/test/build/application 22:39:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:39:39 INFO - Reading from file tmpfile_stdout 22:39:39 INFO - Output received: 22:39:39 INFO - /builds/slave/test/build/application/firefox/firefox 22:39:39 INFO - Running post-action listener: _resource_record_post_action 22:39:39 INFO - ##### 22:39:39 INFO - ##### Running run-tests step. 22:39:39 INFO - ##### 22:39:39 INFO - Running pre-action listener: _resource_record_pre_action 22:39:39 INFO - Running main action method: run_tests 22:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:39:39 INFO - Python 2.7.3 22:39:39 INFO - Return code: 0 22:39:39 INFO - grabbing minidump binary from tooltool 22:39: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')]} 22:39:39 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 0xfc2160>, '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 0xfc3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfc34f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:39:39 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 22:39:39 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 22:39:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:39:40 INFO - Return code: 0 22:39:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:39:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:39:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:39:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:39:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:39:41 INFO - Return code: 0 22:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 22:39:41 INFO - Using env: {'DISPLAY': ':0', 22:39:41 INFO - 'HOME': '/home/cltbld', 22:39:41 INFO - 'LANG': 'en_US.UTF-8', 22:39:41 INFO - 'LANGUAGE': 'en_US:en', 22:39:41 INFO - 'LOGNAME': 'cltbld', 22:39:41 INFO - 'MAIL': '/var/mail/cltbld', 22:39:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:39:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:41 INFO - 'MOZ_NO_REMOTE': '1', 22:39:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:39:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:41 INFO - 'NO_EM_RESTART': '1', 22:39:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:41 INFO - 'PWD': '/builds/slave/test', 22:39:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:39:41 INFO - 'SHELL': '/bin/bash', 22:39:41 INFO - 'SHLVL': '1', 22:39:41 INFO - 'TERM': 'linux', 22:39:41 INFO - 'TMOUT': '86400', 22:39:41 INFO - 'USER': 'cltbld', 22:39:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043', 22:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:41 INFO - '_': '/tools/buildbot/bin/python'} 22:39:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 22:39:41 INFO - mozversion application_buildid: 20160517194042 22:39:41 INFO - mozversion application_changeset: 8483a86bf6720032befd0866987adcfe6b12f03f 22:39:41 INFO - mozversion application_display_name: Firefox 22:39:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:39:41 INFO - mozversion application_name: Firefox 22:39:41 INFO - mozversion application_remotingname: firefox 22:39:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:39:41 INFO - mozversion application_vendor: Mozilla 22:39:41 INFO - mozversion application_version: 47.0 22:39:41 INFO - mozversion platform_buildid: 20160517194042 22:39:41 INFO - mozversion platform_changeset: 8483a86bf6720032befd0866987adcfe6b12f03f 22:39:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:39:41 INFO - mozversion platform_version: 47.0 22:39:41 INFO - using testdate: 1463549981 22:39:41 INFO - actual date: 1463549981 22:39:41 INFO - starting webserver on 'localhost:45100' 22:39:41 INFO - SUITE-START | Running 2 tests 22:39:41 INFO - TEST-START | dromaeo_css 22:39:41 INFO - operating with platform_type : linux_ 22:39:41 INFO - Initialising browser for dromaeo_css test... 22:39:41 INFO - TEST-INFO | started process 3304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOcAX3M/profile http://localhost:45100/getInfo.html) 22:39:45 INFO - PROCESS | 3304 | 22:39:45 INFO - PROCESS | 3304 | (process:3381): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:39:46 INFO - PROCESS | 3304 | __metrics Screen width/height:1600/1200 22:39:46 INFO - PROCESS | 3304 | colorDepth:24 22:39:46 INFO - PROCESS | 3304 | Browser inner width/height: 1024/697 22:39:46 INFO - PROCESS | 3304 | __metrics 22:39:46 ERROR - PROCESS | 3304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 22:39:47 INFO - TEST-INFO | 3304: exit 0 22:39:47 INFO - Browser initialized. 22:39:47 INFO - Running cycle 1/1 for dromaeo_css test... 22:39:47 INFO - TEST-INFO | started process 3431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOcAX3M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:39:49 INFO - PROCESS | 3431 | 22:39:49 INFO - PROCESS | 3431 | (process:3499): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:39:59 INFO - PROCESS | 3431 | RSS: Main: 149356544 22:39:59 INFO - PROCESS | 3431 | 22:40:49 INFO - PROCESS | 3431 | 1463550049188 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] 22:42:57 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:45100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45100/tests/dromaeo/cssquery-ext.html) 22:42:58 INFO - PROCESS | 3431 | RSS: Main: 153731072 22:42:58 INFO - PROCESS | 3431 | 22:45:59 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:45100/tests/dromaeo/cssquery-ext.html (next: http://localhost:45100/tests/dromaeo/cssquery-jquery.html) 22:46:00 INFO - PROCESS | 3431 | RSS: Main: 152223744 22:46:00 INFO - PROCESS | 3431 | 22:49:02 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:45100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45100/tests/dromaeo/cssquery-mootools.html) 22:49:02 INFO - PROCESS | 3431 | RSS: Main: 151613440 22:49:02 INFO - PROCESS | 3431 | 22:52:04 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:45100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45100/tests/dromaeo/cssquery-prototype.html) 22:52:04 INFO - PROCESS | 3431 | RSS: Main: 152350720 22:52:04 INFO - PROCESS | 3431 | 22:55:07 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:45100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45100/tests/dromaeo/cssquery-yui.html) 22:55:07 INFO - PROCESS | 3431 | RSS: Main: 151023616 22:55:07 INFO - PROCESS | 3431 | 22:58:09 INFO - PROCESS | 3431 | Cycle 1(1): loaded http://localhost:45100/tests/dromaeo/cssquery-yui.html (next: http://localhost:45100/tests/dromaeo/cssquery-dojo.html) 22:58:10 INFO - PROCESS | 3431 | RSS: Main: 155291648 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | __start_tp_report 22:58:10 INFO - PROCESS | 3431 | _x_x_mozilla_page_load 22:58:10 INFO - PROCESS | 3431 | _x_x_mozilla_page_load_details 22:58:10 INFO - PROCESS | 3431 | |i|pagename|runs| 22:58:10 INFO - PROCESS | 3431 | |0;dojo.html;3348.6818752218537;3374.696277335039;3398.8470518826653;3409.676080772327;3414.078198886301;5396.595255355849;5404.513593776559;5406.702631355283;5407.080796264635;5417.864553386167;5317.539319132001;5397.757100930457;5410.215518749779;5417.6478528895595;5455.454454554542;4918.975405122978;4944.4313903900975;5010.524000219992;5011.548960593545;5032.672876263031;4838.443578988426;4906.460289368185;4915.287283343913;4944.035912996967;5040.924386134211;4997.700137991714;5033.395992480889;5035.571976382012;5038.319826823387;5049.4950504949575;4968.180250258703;5015.924761128586;5020.171671674169;5033.6728112672745;5051.772670229849;4837.661363704542;4845.4185497740145;4913.754312284372;4936.234883593049;4963.329950456714;5190.818321358772;5211.661242019257;5224.8693782655355;5230.34620672416;5236.973815130938;5818.44724751148;5820.388859169769;5840.88318233633;5846.561507886883;5898.41015898411;5658.094704847246;5807.941920580783;5823;5863.325717542494;5886.6173698709445;5420.512153906088;5422.728863556807;5422.728863556846;5427.1316589345515;5446.046941785172;5808.07070868659;5852.209951656472;5868.794592189253;5869.941300587025;5904.527637788967;5701.116326969326;5750.597458177971;5753;5762.222100016528;5782.5663075268685;5846.035404158266;5854.092615644582;5854.297484301911;5855.4730074292665;5856.707164641836;5654.434556544395;5827.970860145757;5832.212651292106;5834.766609335664;5837.9124313135335;5782.855428614234;5783.392743761844;5785.50823180026;5786.218860453869;5868.706564671749;4402.273624851928;4413.602775750198;4435.911281774411;4440.489343725449;4479.664025198123;3953.189596132786;3989.800509974548;4022.35642297231;4041.696872734498;4056.675465962716;5631.774729010794;5656.575756818255;5667.574931880043;5683.920055189584;5692.48767610917;5892.410758924159;5904.380040095814;5904.76380944766;5918.704064796829;5929.6145750526075;5512.33851937762;5581.972090139523;5609.775608975677;5648.8870222595315;5694.601377903507;5010.599152067826;5040.6219533534395;5042.470540593258;5069.822556210515;5096.541311282002;6079.209702738615;6133.723982420802;6138.846528836725;6143.139960405547;6147.784827531015;5700.344460386943;5849.678267695318;5921.141434491975;5921.792737254175;5931.347551769216;5997.16039754426;6012.338642749207;6026.487748541423;6043.909341359795;6059.575829691879;5703.971480142739;5706.686132262766;5713.857153571194;5718.857028574319;5742.397048309867;5786.247787787561;5886.587938844411;5928.703564821655;5941.732622032106;5981.790637327673;5759.8560035999435;5761.827145185651;5772.884542309046;5776.884462310646;5779.826605201851;5644.745986430703;5748.511376533042;5751.8562035949435;5762.683052432157;5767.711614419179;5649.519790817662;5689.34572524165;5693.800716974886;5706.942930570641;5728.312602487728;5671.347795003628;5711.114777209539;5731.770729170787;5736;5749.511291540266;5339.626226164287;5577.163425486209;5589;5623.3533143689;5633.014222510962 22:58:10 INFO - PROCESS | 3431 | |1;ext.html;499.8575406009288;550.2928736573504;552.9032419326617;574.422705181293;583.9343198662442;37679.24641507171;38192.618073819256;38201;38260.23479530411;38373.61626383735;40373.19253614926;41217;41237;41329.17341653165;41361.58638413615;8850.070742572017;9111.225545828613;9120.224780893632;9128.908710912872;9161.496117713523;8860.601272942733;9014.323925705565;9015.504147271897;9037.18665320121;9037.95481022594;9098.408603440788;9100.908990910106;9153.267738580898;9204.40171388861;9219.078092190794;9067.591958361889;9138.543072846398;9171.816563668723;9179.17387435134;9217.769555761093;9092.090790920854;9249.491277979709;9255;9275;9285.814283714288;40878;41233.793831030955;41280.79359603213;41378;41539.376909346385;3697.3529632314508;3732.8133593320226;3813.1039205786897;3895.590962948906;4279.935800962988;28758;29214.26964325909;29475.852620736758;30492.390152196833;30907.84546077255;3807.067268519203;3830.5977872323283;3836.6163383661687;4165.166966606661;4196.971741923217;276333;278597;278900;281734.5913270441;281767;37680.623193767715;38683.61316386856;65369.67315163489;65499.67250163814;66139.66930165318;38305;39094.60905390966;39260.411093833616;39348.40977385342;39619.80190099031;14733.336999835034;14750.40998360075;14755.55733328002;14761.704765904622;14850.851491485162;11963.46164422603;11982.101342399355;12012.339321337411;12095.81856272139;12100;12877.935610321889;12904;12938.935305323414;13003.869961300456;13156.342182890818;4935.950640493621;5020.723860187724;5042.596592272609;5134.614903882224;5142.460041695643;949.0462085604062;985.4826216236534;1033.503918119307;1078.3152698036804;1082.1883587309517;28273;28653.28366790847;28876.85561572221;29016.709832901823;29243;972.8832540095234;1060.671191930504;1096.6709987003867;1098.6813823990954;1107.191750022472;15122.54632361031;15198.696026079417;15280.541583752505;15293.15887626169;15465.14941678196;314442;366124;372227;458726;485219;50560.24159637609;51101.23348149781;51295.74352128216;51343.48656513462;51551.484485154666;1397.5178563395611;1435.3397437179015;1448.2903377345026;1448.6378405398439;1451.5427640293274;27352.1434886197;27655.170344889684;28264.71735282621;29366.55950160792;30186.547201791553;48427.5157248423;48729;48863.5113648859;48933;48945;305536;309212;309518;310271;311398;30509.54235686422;30524.84737576298;30677.846610766803;31023.84488077545;31078.067657970296;45639.54360456353;45808.312875307565;45934.31098533458;46165.53834461612;46535.53464465447;39016.41475377815;39365.409518856664;39413;39535.2092958145;39686.2062758749;38507.2298554033;39230.607693923834;39288.803555982035;39319.80340098281;39449.80275098606;36903;37183.256334873695;38297.61702383052;38858.2228355437;39183.608163918;32374.35251295008;32432.189195270308;32515.34969300648;32789.67210327866;33027.33945321128;26424.847244424043;26521;26749;26861.24559037922;26901.192964211106 22:58:10 INFO - PROCESS | 3431 | |2;jquery.html;325.8859399210276;335.60231126115553;347.18065365736857;351.56230493036173;355.0520111302821;16799.412020579268;17817.554561135963;18325.7251141233;18329;18526.536836579093;16848.157592120406;17202.91398543009;17398.30406783727;17837.286508539644;17846.910765446155;5303.151495760679;5327.227552004947;5445.809396671118;5454.563634909197;5469.974542005682;5322.121849894782;5367.865803354928;5379.6503227290295;5380.650257733254;5407.891842163154;5241.344831896013;5418.83743487694;5424.701641409721;5501.284832971708;5510.862228444301;5394.946050539504;5432.972835135839;5438.456154384569;5449.891002179934;5456.208849716789;4640.141573808856;4804.735739534324;4809.6392770542;4812.25410061441;4826.638002149853;21195.788042119537;21741;21888;21975.450613734625;22137.335879923627;2363.444590521226;2412.1075202175134;2448.7061552613623;2462.175171317611;2575.7939364850768;13501.32493375337;13860.514881979083;13883.930580347034;14045.227512486808;14196.148231106166;1837.7243413488084;1861.2275905499203;1889.9055047247582;1912.7991560886046;1952.9707054394196;58310.708446457924;62543.6872815633;63783.68108159476;64153.35846641521;64704.676476617315;9532.475713835805;10096.949515252376;10457.790844183226;10510.579576816994;10565.20760942917;14377.20925349095;14388.208648524222;14460.566183014316;14474.565763027125;14555.417783288762;7622;7724.188960159215;7782.92217077822;7799.259070388304;7851.882221766678;7300.233475484997;7400.48196626231;7480.775576732707;7545.773626791205;7553.962230188814;4448.488423831301;4478.552144785495;4496.7077139985795;4523.072770082125;4584.931226031612;1805.873588848768;1811.1397086383863;1828.1042289278423;1851.3150134450339;1876.6246750649925;1029.527775281355;1046.450613427941;1060.1571750458404;1071.8606581144402;1102.1348241630442;17591.82408175902;17598.38405655796;17602.11989400525;17674;17934.730979035325;930.4928813796362;931.7810314576069;970.2868391732071;993.2103977338033;994.8656931314325;10203.38779673222;10266.486675666187;10358.326708764056;10375.584976600852;10488.947555262175;413651;427355;432448;436629;437663;59623;75617.62191189118;77582;78000.60999695079;78677;980.9307854438696;991.8561808537866;1001.6193846338344;1009.3086235928413;1014.4826138669184;16200.756988645415;16226.594335141715;16409.835901640832;16463.176841157656;16651.250693718568;23330.533389332457;35383.64616353803;36245.45631815472;36312.4553131698;36344.27311453809;47829;49721.502784971686;50488.24267636062;50564.74717626535;50659;7701.268379503938;7858.096318923168;7937.603119844101;7939.404544659058;7949.801254968672;11486.94256528712;11873.940630297138;11918.761624767629;12290.385480725748;12514.124011319484;9429.245660347018;9857.852132217879;9987.850182247126;10127.392356458342;10233.488325583543;5172.094883395466;7334.596597187206;10382.948085259526;10770.628808080219;11109;10656.467176641292;11007.779844402907;11111.83332250033;11245.100391968459;11445.141614379121;7443.665035073326;7719.691212351443;7861.410394220342;7948.324392426708;8098.230668086522;8200.958995204986;10203.438810865176;10710.518026688973;10748.570057197625;10753.623623173151 22:58:10 INFO - PROCESS | 3431 | |3;mootools.html;1567.866731327837;1580.8182059063208;1825.4341154242186;1859.4979355573987;1901.59115790105;7511.849763004737;8342.37432192585;8431.873521897176;8637.78405539861;8657.393982421234;8076.313513351372;8127.268545830874;8175.509469431823;8193.836123277531;8209.425340226186;2393.6768536247646;2419.346776370379;2419.9637005444933;2421.2010036687852;2421.2978236311446;2316.664083707861;2319.4549280919055;2353.8705371204665;2367.6330168823774;2377.9286621401384;2405.891734871935;2411.4574220800355;2417.576924038295;2438.6829712137396;2449.7550244975537;2375.5486457573006;2389.629607410854;2394.724606670229;2396.7483414241515;2401.0635852017726;2295.1507942061544;2310.0413328468667;2312.7455979842202;2313.1556981701724;2314.6990891184205;8286.378521610903;8328.417010809246;8330.291925186366;8347.666093356258;8355.623996920152;5152.149895267276;5263.499967503081;5267.3679158500845;5272.604554658377;5274.789008439696;3249;3280.7867488613165;3332.783369081026;3378.476336167898;3421.726261899042;1008.5411137932297;1029.4698230411343;1035.8394448860438;1076.3004047369195;1079.4656644960717;12109.576164834276;12160.817587736192;12200.938995304967;12239;12244.081693872906;4541.500434952152;4669.182892993713;4775.9731657693765;4792.640551958617;4815.662903596714;9382.343235973416;9390.577424015935;9393.812123757487;9484.620615175454;9518.619255229713;5204.505571970657;5243.868903277448;5245.921311180336;5246.213068039825;5250.632455728062;4440.555944405533;4490.348899409567;4501.549845015537;4506.932396014063;4752.714837109785;3550.7869527827897;3581;3584.462330650423;3627.6553727395853;3646.3801153803915;1073.500822117719;1076.230495195923;1078.3260462211117;1085.3325204998869;1097.1113398147527;1143.4168574027306;1158.5597472960221;1178.8172833210865;1182.1665725663386;1183.4556104192168;8021.839563208703;8163.10205877353;8167.224113709188;8219.095899451055;8254.587270636444;1193.1707463313087;1215.4530461292454;1217.689489180271;1221.1696046688337;1238.5603110895684;6387.393197646216;6390.169277993831;6478.773242936474;6487.124238227873;6490.740370385226;10239.334443261165;10794.24440289188;10804.351738895692;10822.404767737693;10846.78306433867;10420.32267902584;10590.046895779416;10590.311629744043;10592.523336449724;10804.837927430937;8269.421140520226;8289.58552072394;8402.957985210034;8405.033421156646;8420;7968.482048666818;8040.316573091352;8054.275115239657;8086.15095414973;8095.676172953016;9385.577649005674;9402.623895044395;9449.48027858447;9468.195203407511;9623.518824058629;9607.759806004906;9831.606735730491;9856.852147217654;9889.159421449258;9898.851517227391;7301.08736407949;7418.554886706815;7435.776926692208;7644.961775191088;7668;8213.712520061768;8214.63034163476;8223.177682231968;8249.79375515617;8270.751877443687;7274.236205198589;7358.889616655862;7457.776266712007;7497.400207983239;7561.3194812467145;7245.673944672397;7326.120865496175;7377.4835761498325;7418.258174182754;7436.59098749574;7755.612219388895;7819.960900195462;7842.215778422112;7877.566733829694;7887.881681774663;6781.728730850711;7059.752908648173;7093.113360829896;7101.680424381018;7142.071530700976;7178.210396856446;7184.425245980205;7202.639868006474;7239.276072392719;7245.5652660840515 22:58:10 INFO - PROCESS | 3431 | |4;prototype.html;325.58975690629813;337.77537937271717;344.41449535789155;344.5245561125646;347.5429809800111;6265.749370025205;6267.749290028393;6301.968490157548;6307.716152773125;6331.366863313667;6205.472534834545;6212.937870621293;6222.097795819604;6224.595401298924;6240.126382306481;4651.325557794118;4745.406824146981;4768.213244814601;4790.113828941657;4806.086843499724;4772.522747725217;4775.928361074587;4779.02030083832;4781.569658730714;4788.9521104788855;4727.290906364038;4731.763411829412;4738.407699037621;4750.548697873696;4759.405074365704;4749.833755818547;4751.477337492873;4759.785809638557;4761.285807128924;4761.857144285677;4114.526829414625;4114.938275925863;4120.979395103035;4127.195196936598;4132;5912.704364781744;5933.703314834284;5940.70296485174;5947.226860508106;5961.195238642771;5332.813351532716;5489.286392768954;5492.0663487206875;5495.422980587021;5499.807506737245;6627.635480048595;6662.833429164261;6663;6665.733370665168;6672.3661252181455;4459.353393757887;4459.375687403766;4471.731696098212;4474.373587697725;4494.68537202396;6934.930650693479;6997.965010174917;7021.368076873106;7023.297670232936;7046.788596342118;4626.884327891829;4636.675432719677;4638.0491999140095;4638.095571363552;4644.233701439292;4721.693089949143;4820.276958456259;4828.444728856227;4833.806647734052;4863.70817750929;5522.585806064561;5556.222128901876;5593.8321850344555;5597.860053498695;5610.579206559524;6720.227173875067;6726.697298621574;6751.223609284897;6755.425788807908;6794.946783248604;1690.9070001150055;1715.305301352954;1715.845573898355;1717.313074770077;1719.9656006879793;1086.1690806533009;1119.7592517608753;1122.0294445304917;1127.2785417332914;1135.500379832871;6543.44380727634;6560.573562718503;6561;6561.835954101186;6571.769988050491;6868;6905.37851593359;6930.688119034656;6949.965250173818;6973.755918542928;6469.482441404676;6567.211934567787;6647.933520664828;6667.833304167338;6673.632950187689;3781.1681430085337;3786.8295926683363;3800.56293526248;3806.562245341821;3817.1602247505502;7338.486305958639;7350.889736653954;7353.338199562065;7374.151972523121;7382.704691812267;7165.713371465187;7196.172440169343;7204.9279507204255;7219.747308844166;7225.421966242688;7206.243344448862;7351.632418379167;7392.4086073115095;7410.666520006613;7412.740554080581;6999.12510936133;7015.508914375945;7021.5787052777;7036.437085033287;7044.823879403056;6908.723651053901;6909.2399836019;6910.896336555056;6911.516193866381;6918.584884906922;7369.77890663281;7384.18773934856;7388.224236455095;7389.150247721581;7391.593462359622;4508.256137737237;4629.513901040477;4636.721796692209;4645.070985802786;4650.604698600657;6921.826954326182;6963.895541566982;6966.9303306966285;6980.7905762827195;6983;6724.361185687352;6731.32686731323;6758.189017317954;6768.492363072888;6776.356246156607;6716.328367163244;6739.022841688025;6758.763443279461;6769.763058292936;6770.1537307836525;6490;6601.207855057424;6613.338666133348;6621.370969757865;6644.501662375438;6694.933050669431;6729.327067293231;6738.35985581369;6740.618173274565;6758.5269031167345;6564.277929427663;6593.769218077345;6602.161070739436;6602.702878370581;6618.073469714148 22:58:10 INFO - PROCESS | 3431 | |5;yui.html;876.1982785751037;888.6578667213125;903.4263242840798;904.127516946147;913.8903331600209;14533.927330363333;14586.270686465674;14676.779848302283;14824.407023719052;14860.702785944275;14347.928260358709;14400.423983040666;14448.638784030405;14449.855501444983;14451.638709032279;918.3387960668308;940.8447606144978;943.3208090175098;944.0606596436555;944.315371355765;938.737153596994;941.472775245861;941.6327632223438;944.0087907696925;945.9385139965915;971.815355082532;973.0172525749009;980.0640388429068;980.240313756837;982.1013772398247;963.9036096390375;964.7877466957258;966.5988614724915;970.0590427285522;987.3878195518824;724.3770357492552;726.0923845193508;727.3054233207274;727.3671905442299;731.3600599475459;15147.772783408258;15300.923495382563;15338.923305383514;15346.232688365648;15416.614584635361;13957.302134893316;14081.5071472499;14089;14101.2244326562;14105.717885642229;10480.161587073093;10514.106300964428;10568.52441640128;11070.833937490945;11365.829512557319;3816.160444702161;3862.0344913771555;3866.4586957825927;3866.8646597368956;3918.960810391888;52771.736141319045;52782.736086319324;52966.47033529654;53168.46831531713;53488.73255633736;10401.895981040092;10798.244122911477;10912.236143469881;11355;11773.411329433666;19637.60724785525;19943;19949.301774437827;19986.000699964945;20098;8149.388795840336;8255.545944973084;8328.292095171857;8330.416870819106;8389.203025712548;4441.666874984389;4465.620422264144;4599.126166028444;4640.767961601907;4723.834665786681;3167.588213532226;3216.067340471237;3238.028591422611;3240.206149493389;3243.8053716777067;603.8792241551707;609.2506217352593;614.3856143856144;614.6250787019915;617.9443850053517;665.5540787672271;747.3610063395719;757.5038349880837;764.5030730025417;777.1800750208471;8978.551072446351;9000.414973026733;9198.126178013212;9303.348765586345;9575.760605984768;634.5462993959342;683.8187880211748;687.542784048612;689.2142957028991;707.0560801330282;4370.366296886934;4692.4603670577635;4700.294955756595;4797.088553174885;4862.465128835825;58552;58856.41143588595;61717.69141154355;62145.067823982674;62441.37558624447;54293;54783;55658.72170639202;56039;56060;48455;48570;48629.75685121552;49056.26415603769;49594;9560.426374417557;9773.31586788918;9775.315727898978;9807;9846.064623860722;33537;35090;35477.82261088678;36008.63991360053;36010.819945900104;40956.38565421462;41056;43412;44432.77783611061;44767.10465790731;11830.881691182978;12018;12291.139620226499;12323;12647.114701970773;13401.798973015217;13490.460381584626;13691.794623080463;13691.931540342634;14189.858101418853;12417.565385211474;12596.685082873002;12652.683682908;12783.93608031954;13186;12104.818427723416;13045.739085218433;13047.151935124186;13386.933065334611;13581.796273055714;11588.188826782045;12913.548025819051;12982.675433114247;13274.867251327749;13279.66800829987;10202.081812636898;10470;10579.523921423708;10981.231313807957;11132.777344452903;10873.456327183767;11066.612668556561;11125.666230013112;11226.494807733508;11388.430578470878 22:58:10 INFO - PROCESS | 3431 | __end_tp_report 22:58:10 INFO - PROCESS | 3431 | __start_cc_report 22:58:10 INFO - PROCESS | 3431 | _x_x_mozilla_cycle_collect,314 22:58:10 INFO - PROCESS | 3431 | __end_cc_report 22:58:10 INFO - PROCESS | 3431 | __startTimestamp1463551090055__endTimestamp 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | ------- Summary: start ------- 22:58:10 INFO - PROCESS | 3431 | Number of tests: 6 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | [#0] dojo.html Cycles:165 Average:5430.86 Median:5683.92 stddev:593.98 (10.5%) stddev-sans-first:572.90 22:58:10 INFO - PROCESS | 3431 | Values: 3348.7 3374.7 3398.8 3409.7 3414.1 5396.6 5404.5 5406.7 5407.1 5417.9 5317.5 5397.8 5410.2 5417.6 5455.5 4919.0 4944.4 5010.5 5011.5 5032.7 4838.4 4906.5 4915.3 4944.0 5040.9 4997.7 5033.4 5035.6 5038.3 5049.5 4968.2 5015.9 5020.2 5033.7 5051.8 4837.7 4845.4 4913.8 4936.2 4963.3 5190.8 5211.7 5224.9 5230.3 5237.0 5818.4 5820.4 5840.9 5846.6 5898.4 5658.1 5807.9 5823.0 5863.3 5886.6 5420.5 5422.7 5422.7 5427.1 5446.0 5808.1 5852.2 5868.8 5869.9 5904.5 5701.1 5750.6 5753.0 5762.2 5782.6 5846.0 5854.1 5854.3 5855.5 5856.7 5654.4 5828.0 5832.2 5834.8 5837.9 5782.9 5783.4 5785.5 5786.2 5868.7 4402.3 4413.6 4435.9 4440.5 4479.7 3953.2 3989.8 4022.4 4041.7 4056.7 5631.8 5656.6 5667.6 5683.9 5692.5 5892.4 5904.4 5904.8 5918.7 5929.6 5512.3 5582.0 5609.8 5648.9 5694.6 5010.6 5040.6 5042.5 5069.8 5096.5 6079.2 6133.7 6138.8 6143.1 6147.8 5700.3 5849.7 5921.1 5921.8 5931.3 5997.2 6012.3 6026.5 6043.9 6059.6 5704.0 5706.7 5713.9 5718.9 5742.4 5786.2 5886.6 5928.7 5941.7 5981.8 5759.9 5761.8 5772.9 5776.9 5779.8 5644.7 5748.5 5751.9 5762.7 5767.7 5649.5 5689.3 5693.8 5706.9 5728.3 5671.3 5711.1 5731.8 5736.0 5749.5 5339.6 5577.2 5589.0 5623.4 5633.0 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | [#1] ext.html Cycles:180 Average:48883.28 Median:38440.42 stddev:88256.08 (229.6%) stddev-sans-first:88428.90 22:58:10 INFO - PROCESS | 3431 | Values: 499.9 550.3 552.9 574.4 583.9 37679.2 38192.6 38201.0 38260.2 38373.6 40373.2 41217.0 41237.0 41329.2 41361.6 8850.1 9111.2 9120.2 9128.9 9161.5 8860.6 9014.3 9015.5 9037.2 9038.0 9098.4 9100.9 9153.3 9204.4 9219.1 9067.6 9138.5 9171.8 9179.2 9217.8 9092.1 9249.5 9255.0 9275.0 9285.8 40878.0 41233.8 41280.8 41378.0 41539.4 3697.4 3732.8 3813.1 3895.6 4279.9 28758.0 29214.3 29475.9 30492.4 30907.8 3807.1 3830.6 3836.6 4165.2 4197.0 276333.0 278597.0 278900.0 281734.6 281767.0 37680.6 38683.6 65369.7 65499.7 66139.7 38305.0 39094.6 39260.4 39348.4 39619.8 14733.3 14750.4 14755.6 14761.7 14850.9 11963.5 11982.1 12012.3 12095.8 12100.0 12877.9 12904.0 12938.9 13003.9 13156.3 4936.0 5020.7 5042.6 5134.6 5142.5 949.0 985.5 1033.5 1078.3 1082.2 28273.0 28653.3 28876.9 29016.7 29243.0 972.9 1060.7 1096.7 1098.7 1107.2 15122.5 15198.7 15280.5 15293.2 15465.1 314442.0 366124.0 372227.0 458726.0 485219.0 50560.2 51101.2 51295.7 51343.5 51551.5 1397.5 1435.3 1448.3 1448.6 1451.5 27352.1 27655.2 28264.7 29366.6 30186.5 48427.5 48729.0 48863.5 48933.0 48945.0 305536.0 309212.0 309518.0 310271.0 311398.0 30509.5 30524.8 30677.8 31023.8 31078.1 45639.5 45808.3 45934.3 46165.5 46535.5 39016.4 39365.4 39413.0 39535.2 39686.2 38507.2 39230.6 39288.8 39319.8 39449.8 36903.0 37183.3 38297.6 38858.2 39183.6 32374.4 32432.2 32515.3 32789.7 33027.3 26424.8 26521.0 26749.0 26861.2 26901.2 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | [#2] jquery.html Cycles:180 Average:25365.67 Median:17867.60 stddev:70469.10 (394.4%) stddev-sans-first:70641.70 22:58:10 INFO - PROCESS | 3431 | Values: 325.9 335.6 347.2 351.6 355.1 16799.4 17817.6 18325.7 18329.0 18526.5 16848.2 17202.9 17398.3 17837.3 17846.9 5303.2 5327.2 5445.8 5454.6 5470.0 5322.1 5367.9 5379.7 5380.7 5407.9 5241.3 5418.8 5424.7 5501.3 5510.9 5394.9 5433.0 5438.5 5449.9 5456.2 4640.1 4804.7 4809.6 4812.3 4826.6 21195.8 21741.0 21888.0 21975.5 22137.3 2363.4 2412.1 2448.7 2462.2 2575.8 13501.3 13860.5 13883.9 14045.2 14196.1 1837.7 1861.2 1889.9 1912.8 1953.0 58310.7 62543.7 63783.7 64153.4 64704.7 9532.5 10096.9 10457.8 10510.6 10565.2 14377.2 14388.2 14460.6 14474.6 14555.4 7622.0 7724.2 7782.9 7799.3 7851.9 7300.2 7400.5 7480.8 7545.8 7554.0 4448.5 4478.6 4496.7 4523.1 4584.9 1805.9 1811.1 1828.1 1851.3 1876.6 1029.5 1046.5 1060.2 1071.9 1102.1 17591.8 17598.4 17602.1 17674.0 17934.7 930.5 931.8 970.3 993.2 994.9 10203.4 10266.5 10358.3 10375.6 10488.9 413651.0 427355.0 432448.0 436629.0 437663.0 59623.0 75617.6 77582.0 78000.6 78677.0 980.9 991.9 1001.6 1009.3 1014.5 16200.8 16226.6 16409.8 16463.2 16651.3 23330.5 35383.6 36245.5 36312.5 36344.3 47829.0 49721.5 50488.2 50564.7 50659.0 7701.3 7858.1 7937.6 7939.4 7949.8 11486.9 11873.9 11918.8 12290.4 12514.1 9429.2 9857.9 9987.9 10127.4 10233.5 5172.1 7334.6 10382.9 10770.6 11109.0 10656.5 11007.8 11111.8 11245.1 11445.1 7443.7 7719.7 7861.4 7948.3 8098.2 8201.0 10203.4 10710.5 10748.6 10753.6 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | [#3] mootools.html Cycles:180 Average:5984.78 Median:5257.07 stddev:3188.32 (60.6%) stddev-sans-first:3179.99 22:58:10 INFO - PROCESS | 3431 | Values: 1567.9 1580.8 1825.4 1859.5 1901.6 7511.8 8342.4 8431.9 8637.8 8657.4 8076.3 8127.3 8175.5 8193.8 8209.4 2393.7 2419.3 2420.0 2421.2 2421.3 2316.7 2319.5 2353.9 2367.6 2377.9 2405.9 2411.5 2417.6 2438.7 2449.8 2375.5 2389.6 2394.7 2396.7 2401.1 2295.2 2310.0 2312.7 2313.2 2314.7 8286.4 8328.4 8330.3 8347.7 8355.6 5152.1 5263.5 5267.4 5272.6 5274.8 3249.0 3280.8 3332.8 3378.5 3421.7 1008.5 1029.5 1035.8 1076.3 1079.5 12109.6 12160.8 12200.9 12239.0 12244.1 4541.5 4669.2 4776.0 4792.6 4815.7 9382.3 9390.6 9393.8 9484.6 9518.6 5204.5 5243.9 5245.9 5246.2 5250.6 4440.6 4490.3 4501.5 4506.9 4752.7 3550.8 3581.0 3584.5 3627.7 3646.4 1073.5 1076.2 1078.3 1085.3 1097.1 1143.4 1158.6 1178.8 1182.2 1183.5 8021.8 8163.1 8167.2 8219.1 8254.6 1193.2 1215.5 1217.7 1221.2 1238.6 6387.4 6390.2 6478.8 6487.1 6490.7 10239.3 10794.2 10804.4 10822.4 10846.8 10420.3 10590.0 10590.3 10592.5 10804.8 8269.4 8289.6 8403.0 8405.0 8420.0 7968.5 8040.3 8054.3 8086.2 8095.7 9385.6 9402.6 9449.5 9468.2 9623.5 9607.8 9831.6 9856.9 9889.2 9898.9 7301.1 7418.6 7435.8 7645.0 7668.0 8213.7 8214.6 8223.2 8249.8 8270.8 7274.2 7358.9 7457.8 7497.4 7561.3 7245.7 7326.1 7377.5 7418.3 7436.6 7755.6 7820.0 7842.2 7877.6 7887.9 6781.7 7059.8 7093.1 7101.7 7142.1 7178.2 7184.4 7202.6 7239.3 7245.6 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | [#4] prototype.html Cycles:180 Average:5618.86 Median:6479.74 stddev:1732.97 (26.7%) stddev-sans-first:1691.67 22:58:10 INFO - PROCESS | 3431 | Values: 325.6 337.8 344.4 344.5 347.5 6265.7 6267.7 6302.0 6307.7 6331.4 6205.5 6212.9 6222.1 6224.6 6240.1 4651.3 4745.4 4768.2 4790.1 4806.1 4772.5 4775.9 4779.0 4781.6 4789.0 4727.3 4731.8 4738.4 4750.5 4759.4 4749.8 4751.5 4759.8 4761.3 4761.9 4114.5 4114.9 4121.0 4127.2 4132.0 5912.7 5933.7 5940.7 5947.2 5961.2 5332.8 5489.3 5492.1 5495.4 5499.8 6627.6 6662.8 6663.0 6665.7 6672.4 4459.4 4459.4 4471.7 4474.4 4494.7 6934.9 6998.0 7021.4 7023.3 7046.8 4626.9 4636.7 4638.0 4638.1 4644.2 4721.7 4820.3 4828.4 4833.8 4863.7 5522.6 5556.2 5593.8 5597.9 5610.6 6720.2 6726.7 6751.2 6755.4 6794.9 1690.9 1715.3 1715.8 1717.3 1720.0 1086.2 1119.8 1122.0 1127.3 1135.5 6543.4 6560.6 6561.0 6561.8 6571.8 6868.0 6905.4 6930.7 6950.0 6973.8 6469.5 6567.2 6647.9 6667.8 6673.6 3781.2 3786.8 3800.6 3806.6 3817.2 7338.5 7350.9 7353.3 7374.2 7382.7 7165.7 7196.2 7204.9 7219.7 7225.4 7206.2 7351.6 7392.4 7410.7 7412.7 6999.1 7015.5 7021.6 7036.4 7044.8 6908.7 6909.2 6910.9 6911.5 6918.6 7369.8 7384.2 7388.2 7389.2 7391.6 4508.3 4629.5 4636.7 4645.1 4650.6 6921.8 6963.9 6966.9 6980.8 6983.0 6724.4 6731.3 6758.2 6768.5 6776.4 6716.3 6739.0 6758.8 6769.8 6770.2 6490.0 6601.2 6613.3 6621.4 6644.5 6694.9 6729.3 6738.4 6740.6 6758.5 6564.3 6593.8 6602.2 6602.7 6618.1 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - PROCESS | 3431 | [#5] yui.html Cycles:180 Average:14827.80 Median:24449.20 stddev:16728.13 (68.4%) stddev-sans-first:16742.25 22:58:10 INFO - PROCESS | 3431 | Values: 876.2 888.7 903.4 904.1 913.9 14533.9 14586.3 14676.8 14824.4 14860.7 14347.9 14400.4 14448.6 14449.9 14451.6 918.3 940.8 943.3 944.1 944.3 938.7 941.5 941.6 944.0 945.9 971.8 973.0 980.1 980.2 982.1 963.9 964.8 966.6 970.1 987.4 724.4 726.1 727.3 727.4 731.4 15147.8 15300.9 15338.9 15346.2 15416.6 13957.3 14081.5 14089.0 14101.2 14105.7 10480.2 10514.1 10568.5 11070.8 11365.8 3816.2 3862.0 3866.5 3866.9 3919.0 52771.7 52782.7 52966.5 53168.5 53488.7 10401.9 10798.2 10912.2 11355.0 11773.4 19637.6 19943.0 19949.3 19986.0 20098.0 8149.4 8255.5 8328.3 8330.4 8389.2 4441.7 4465.6 4599.1 4640.8 4723.8 3167.6 3216.1 3238.0 3240.2 3243.8 603.9 609.3 614.4 614.6 617.9 665.6 747.4 757.5 764.5 777.2 8978.6 9000.4 9198.1 9303.3 9575.8 634.5 683.8 687.5 689.2 707.1 4370.4 4692.5 4700.3 4797.1 4862.5 58552.0 58856.4 61717.7 62145.1 62441.4 54293.0 54783.0 55658.7 56039.0 56060.0 48455.0 48570.0 48629.8 49056.3 49594.0 9560.4 9773.3 9775.3 9807.0 9846.1 33537.0 35090.0 35477.8 36008.6 36010.8 40956.4 41056.0 43412.0 44432.8 44767.1 11830.9 12018.0 12291.1 12323.0 12647.1 13401.8 13490.5 13691.8 13691.9 14189.9 12417.6 12596.7 12652.7 12783.9 13186.0 12104.8 13045.7 13047.2 13386.9 13581.8 11588.2 12913.5 12982.7 13274.9 13279.7 10202.1 10470.0 10579.5 10981.2 11132.8 10873.5 11066.6 11125.7 11226.5 11388.4 22:58:10 INFO - PROCESS | 3431 | -------- Summary: end -------- 22:58:10 INFO - PROCESS | 3431 | 22:58:10 INFO - TEST-INFO | 3431: exit 0 22:58:10 INFO - TEST-OK | dromaeo_css | took 1109271ms 22:58:10 INFO - TEST-START | kraken 22:58:10 INFO - operating with platform_type : linux_ 22:58:10 INFO - Initialising browser for kraken test... 22:58:10 INFO - TEST-INFO | started process 3676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QJD6M/profile http://localhost:45100/getInfo.html) 22:58:14 INFO - PROCESS | 3676 | 22:58:14 INFO - PROCESS | 3676 | (process:3752): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:58:15 INFO - PROCESS | 3676 | __metrics Screen width/height:1600/1200 22:58:15 INFO - PROCESS | 3676 | colorDepth:24 22:58:15 INFO - PROCESS | 3676 | Browser inner width/height: 1024/697 22:58:15 INFO - PROCESS | 3676 | __metrics 22:58:15 ERROR - PROCESS | 3676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 22:58:16 INFO - TEST-INFO | 3676: exit 0 22:58:16 INFO - Browser initialized. 22:58:16 INFO - Running cycle 1/1 for kraken test... 22:58:16 INFO - TEST-INFO | started process 3802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QJD6M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:18 INFO - PROCESS | 3802 | 22:58:18 INFO - PROCESS | 3802 | (process:3871): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:58:28 INFO - PROCESS | 3802 | RSS: Main: 149667840 22:58:28 INFO - PROCESS | 3802 | 22:58:30 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45100/tests/kraken/driver.html?testName=audio-beat-detection) 22:58:31 INFO - PROCESS | 3802 | RSS: Main: 153575424 22:58:31 INFO - PROCESS | 3802 | 22:58:34 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45100/tests/kraken/driver.html?testName=audio-dft) 22:58:34 INFO - PROCESS | 3802 | RSS: Main: 154382336 22:58:34 INFO - PROCESS | 3802 | 22:58:37 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45100/tests/kraken/driver.html?testName=audio-fft) 22:58:38 INFO - PROCESS | 3802 | RSS: Main: 154783744 22:58:38 INFO - PROCESS | 3802 | 22:58:40 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45100/tests/kraken/driver.html?testName=audio-oscillator) 22:58:40 INFO - PROCESS | 3802 | RSS: Main: 154558464 22:58:40 INFO - PROCESS | 3802 | 22:58:43 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:58:43 INFO - PROCESS | 3802 | RSS: Main: 154718208 22:58:43 INFO - PROCESS | 3802 | 22:58:46 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45100/tests/kraken/driver.html?testName=imaging-darkroom) 22:58:47 INFO - PROCESS | 3802 | RSS: Main: 154791936 22:58:47 INFO - PROCESS | 3802 | 22:58:50 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45100/tests/kraken/driver.html?testName=imaging-desaturate) 22:58:51 INFO - PROCESS | 3802 | RSS: Main: 154898432 22:58:51 INFO - PROCESS | 3802 | 22:58:54 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45100/tests/kraken/driver.html?testName=json-parse-financial) 22:58:54 INFO - PROCESS | 3802 | RSS: Main: 155176960 22:58:54 INFO - PROCESS | 3802 | 22:58:56 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:58:56 INFO - PROCESS | 3802 | RSS: Main: 155348992 22:58:56 INFO - PROCESS | 3802 | 22:58:58 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:58:59 INFO - PROCESS | 3802 | RSS: Main: 155176960 22:58:59 INFO - PROCESS | 3802 | 22:59:01 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:59:01 INFO - PROCESS | 3802 | RSS: Main: 155406336 22:59:01 INFO - PROCESS | 3802 | 22:59:04 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:59:04 INFO - PROCESS | 3802 | RSS: Main: 155639808 22:59:04 INFO - PROCESS | 3802 | 22:59:07 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:59:07 INFO - PROCESS | 3802 | RSS: Main: 155402240 22:59:07 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:45100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45100/tests/kraken/driver.html?testName=ai-astar) 22:59:09 INFO - PROCESS | 3802 | RSS: Main: 157102080 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | __start_tp_report 22:59:09 INFO - PROCESS | 3802 | _x_x_mozilla_page_load 22:59:09 INFO - PROCESS | 3802 | _x_x_mozilla_page_load_details 22:59:09 INFO - PROCESS | 3802 | |i|pagename|runs| 22:59:09 INFO - PROCESS | 3802 | |0;ai-astar;115;104;114;113;114;122;111;109;112;111 22:59:09 INFO - PROCESS | 3802 | |1;audio-beat-detection;154;126;151;174;132;152;154;139;174;130 22:59:09 INFO - PROCESS | 3802 | |2;audio-dft;162;163;162;163;162;160;164;162;165;161 22:59:09 INFO - PROCESS | 3802 | |3;audio-fft;75;73;76;168;76;76;73;76;159;75 22:59:09 INFO - PROCESS | 3802 | |4;audio-oscillator;91;92;138;92;92;93;143;92;91;139 22:59:09 INFO - PROCESS | 3802 | |5;imaging-gaussian-blur;117;118;117;118;117;117;118;118;118;118 22:59:09 INFO - PROCESS | 3802 | |6;imaging-darkroom;148;147;147;147;147;148;147;148;146;149 22:59:09 INFO - PROCESS | 3802 | |7;imaging-desaturate;96;96;96;96;97;96;96;95;96;97 22:59:09 INFO - PROCESS | 3802 | |8;json-parse-financial;58;57;61;55;57;57;56;55;65;55 22:59:09 INFO - PROCESS | 3802 | |9;json-stringify-tinderbox;65;64;62;63;64;64;64;64;65;65 22:59:09 INFO - PROCESS | 3802 | |10;stanford-crypto-aes;77;80;79;84;79;78;78;78;78;80 22:59:09 INFO - PROCESS | 3802 | |11;stanford-crypto-ccm;113;114;129;113;120;119;121;121;120;114 22:59:09 INFO - PROCESS | 3802 | |12;stanford-crypto-pbkdf2;136;144;165;143;137;136;145;144;149;136 22:59:09 INFO - PROCESS | 3802 | |13;stanford-crypto-sha256-iterative;73;74;76;75;72;71;70;72;71;71 22:59:09 INFO - PROCESS | 3802 | __end_tp_report 22:59:09 INFO - PROCESS | 3802 | __start_cc_report 22:59:09 INFO - PROCESS | 3802 | _x_x_mozilla_cycle_collect,813 22:59:09 INFO - PROCESS | 3802 | __end_cc_report 22:59:09 INFO - PROCESS | 3802 | __startTimestamp1463551149909__endTimestamp 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | ------- Summary: start ------- 22:59:09 INFO - PROCESS | 3802 | Number of tests: 14 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:4.60 (4.1%) stddev-sans-first:4.79 22:59:09 INFO - PROCESS | 3802 | Values: 115.0 104.0 114.0 113.0 114.0 122.0 111.0 109.0 112.0 111.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:153.00 stddev:16.97 (11.1%) stddev-sans-first:17.88 22:59:09 INFO - PROCESS | 3802 | Values: 154.0 126.0 151.0 174.0 132.0 152.0 154.0 139.0 174.0 130.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 22:59:09 INFO - PROCESS | 3802 | Values: 162.0 163.0 162.0 163.0 162.0 160.0 164.0 162.0 165.0 161.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#3] audio-fft Cycles:10 Average:92.70 Median:75.50 stddev:37.39 (49.5%) stddev-sans-first:39.11 22:59:09 INFO - PROCESS | 3802 | Values: 75.0 73.0 76.0 168.0 76.0 76.0 73.0 76.0 159.0 75.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#4] audio-oscillator Cycles:10 Average:106.30 Median:92.00 stddev:23.30 (25.3%) stddev-sans-first:24.04 22:59:09 INFO - PROCESS | 3802 | Values: 91.0 92.0 138.0 92.0 92.0 93.0 143.0 92.0 91.0 139.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:59:09 INFO - PROCESS | 3802 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 22:59:09 INFO - PROCESS | 3802 | Values: 148.0 147.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 149.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:59:09 INFO - PROCESS | 3802 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 97.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.17 (5.6%) stddev-sans-first:3.36 22:59:09 INFO - PROCESS | 3802 | Values: 58.0 57.0 61.0 55.0 57.0 57.0 56.0 55.0 65.0 55.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 22:59:09 INFO - PROCESS | 3802 | Values: 65.0 64.0 62.0 63.0 64.0 64.0 64.0 64.0 65.0 65.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.97 (2.5%) stddev-sans-first:1.94 22:59:09 INFO - PROCESS | 3802 | Values: 77.0 80.0 79.0 84.0 79.0 78.0 78.0 78.0 78.0 80.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:120.00 stddev:5.04 (4.2%) stddev-sans-first:4.95 22:59:09 INFO - PROCESS | 3802 | Values: 113.0 114.0 129.0 113.0 120.0 119.0 121.0 121.0 120.0 114.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:144.00 stddev:8.86 (6.2%) stddev-sans-first:8.97 22:59:09 INFO - PROCESS | 3802 | Values: 136.0 144.0 165.0 143.0 137.0 136.0 145.0 144.0 149.0 136.0 22:59:09 INFO - PROCESS | 3802 | 22:59:09 INFO - PROCESS | 3802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:1.96 (2.7%) stddev-sans-first:2.07 22:59:09 INFO - PROCESS | 3802 | Values: 73.0 74.0 76.0 75.0 72.0 71.0 70.0 72.0 71.0 71.0 22:59:09 INFO - PROCESS | 3802 | -------- Summary: end -------- 22:59:09 INFO - PROCESS | 3802 | 22:59:10 INFO - TEST-INFO | 3802: exit 0 22:59:10 INFO - TEST-OK | kraken | took 60127ms 22:59:10 INFO - SUITE-END | took 1169s 22:59:11 INFO - Completed test suite (00:19:29) 22:59:11 INFO - javascript benchmark 22:59:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3348.6818752218537, 3374.696277335039, 3398.8470518826653, 3409.676080772327, 3414.078198886301, 5396.595255355849, 5404.513593776559, 5406.702631355283, 5407.080796264635, 5417.864553386167, 5317.539319132001, 5397.757100930457, 5410.215518749779, 5417.6478528895595, 5455.454454554542, 4918.975405122978, 4944.4313903900975, 5010.524000219992, 5011.548960593545, 5032.672876263031, 4838.443578988426, 4906.460289368185, 4915.287283343913, 4944.035912996967, 5040.924386134211, 4997.700137991714, 5033.395992480889, 5035.571976382012, 5038.319826823387, 5049.4950504949575, 4968.180250258703, 5015.924761128586, 5020.171671674169, 5033.6728112672745, 5051.772670229849, 4837.661363704542, 4845.4185497740145, 4913.754312284372, 4936.234883593049, 4963.329950456714, 5190.818321358772, 5211.661242019257, 5224.8693782655355, 5230.34620672416, 5236.973815130938, 5818.44724751148, 5820.388859169769, 5840.88318233633, 5846.561507886883, 5898.41015898411, 5658.094704847246, 5807.941920580783, 5823.0, 5863.325717542494, 5886.6173698709445, 5420.512153906088, 5422.728863556807, 5422.728863556846, 5427.1316589345515, 5446.046941785172, 5808.07070868659, 5852.209951656472, 5868.794592189253, 5869.941300587025, 5904.527637788967, 5701.116326969326, 5750.597458177971, 5753.0, 5762.222100016528, 5782.5663075268685, 5846.035404158266, 5854.092615644582, 5854.297484301911, 5855.4730074292665, 5856.707164641836, 5654.434556544395, 5827.970860145757, 5832.212651292106, 5834.766609335664, 5837.9124313135335, 5782.855428614234, 5783.392743761844, 5785.50823180026, 5786.218860453869, 5868.706564671749, 4402.273624851928, 4413.602775750198, 4435.911281774411, 4440.489343725449, 4479.664025198123, 3953.189596132786, 3989.800509974548, 4022.35642297231, 4041.696872734498, 4056.675465962716, 5631.774729010794, 5656.575756818255, 5667.574931880043, 5683.920055189584, 5692.48767610917, 5892.410758924159, 5904.380040095814, 5904.76380944766, 5918.704064796829, 5929.6145750526075, 5512.33851937762, 5581.972090139523, 5609.775608975677, 5648.8870222595315, 5694.601377903507, 5010.599152067826, 5040.6219533534395, 5042.470540593258, 5069.822556210515, 5096.541311282002, 6079.209702738615, 6133.723982420802, 6138.846528836725, 6143.139960405547, 6147.784827531015, 5700.344460386943, 5849.678267695318, 5921.141434491975, 5921.792737254175, 5931.347551769216, 5997.16039754426, 6012.338642749207, 6026.487748541423, 6043.909341359795, 6059.575829691879, 5703.971480142739, 5706.686132262766, 5713.857153571194, 5718.857028574319, 5742.397048309867, 5786.247787787561, 5886.587938844411, 5928.703564821655, 5941.732622032106, 5981.790637327673, 5759.8560035999435, 5761.827145185651, 5772.884542309046, 5776.884462310646, 5779.826605201851, 5644.745986430703, 5748.511376533042, 5751.8562035949435, 5762.683052432157, 5767.711614419179, 5649.519790817662, 5689.34572524165, 5693.800716974886, 5706.942930570641, 5728.312602487728, 5671.347795003628, 5711.114777209539, 5731.770729170787, 5736.0, 5749.511291540266, 5339.626226164287, 5577.163425486209, 5589.0, 5623.3533143689, 5633.014222510962], "unit": "score", "name": "dojo.html", "value": 5393.427599332369}, {"lowerIsBetter": false, "replicates": [499.8575406009288, 550.2928736573504, 552.9032419326617, 574.422705181293, 583.9343198662442, 37679.24641507171, 38192.618073819256, 38201.0, 38260.23479530411, 38373.61626383735, 40373.19253614926, 41217.0, 41237.0, 41329.17341653165, 41361.58638413615, 8850.070742572017, 9111.225545828613, 9120.224780893632, 9128.908710912872, 9161.496117713523, 8860.601272942733, 9014.323925705565, 9015.504147271897, 9037.18665320121, 9037.95481022594, 9098.408603440788, 9100.908990910106, 9153.267738580898, 9204.40171388861, 9219.078092190794, 9067.591958361889, 9138.543072846398, 9171.816563668723, 9179.17387435134, 9217.769555761093, 9092.090790920854, 9249.491277979709, 9255.0, 9275.0, 9285.814283714288, 40878.0, 41233.793831030955, 41280.79359603213, 41378.0, 41539.376909346385, 3697.3529632314508, 3732.8133593320226, 3813.1039205786897, 3895.590962948906, 4279.935800962988, 28758.0, 29214.26964325909, 29475.852620736758, 30492.390152196833, 30907.84546077255, 3807.067268519203, 3830.5977872323283, 3836.6163383661687, 4165.166966606661, 4196.971741923217, 276333.0, 278597.0, 278900.0, 281734.5913270441, 281767.0, 37680.623193767715, 38683.61316386856, 65369.67315163489, 65499.67250163814, 66139.66930165318, 38305.0, 39094.60905390966, 39260.411093833616, 39348.40977385342, 39619.80190099031, 14733.336999835034, 14750.40998360075, 14755.55733328002, 14761.704765904622, 14850.851491485162, 11963.46164422603, 11982.101342399355, 12012.339321337411, 12095.81856272139, 12100.0, 12877.935610321889, 12904.0, 12938.935305323414, 13003.869961300456, 13156.342182890818, 4935.950640493621, 5020.723860187724, 5042.596592272609, 5134.614903882224, 5142.460041695643, 949.0462085604062, 985.4826216236534, 1033.503918119307, 1078.3152698036804, 1082.1883587309517, 28273.0, 28653.28366790847, 28876.85561572221, 29016.709832901823, 29243.0, 972.8832540095234, 1060.671191930504, 1096.6709987003867, 1098.6813823990954, 1107.191750022472, 15122.54632361031, 15198.696026079417, 15280.541583752505, 15293.15887626169, 15465.14941678196, 314442.0, 366124.0, 372227.0, 458726.0, 485219.0, 50560.24159637609, 51101.23348149781, 51295.74352128216, 51343.48656513462, 51551.484485154666, 1397.5178563395611, 1435.3397437179015, 1448.2903377345026, 1448.6378405398439, 1451.5427640293274, 27352.1434886197, 27655.170344889684, 28264.71735282621, 29366.55950160792, 30186.547201791553, 48427.5157248423, 48729.0, 48863.5113648859, 48933.0, 48945.0, 305536.0, 309212.0, 309518.0, 310271.0, 311398.0, 30509.54235686422, 30524.84737576298, 30677.846610766803, 31023.84488077545, 31078.067657970296, 45639.54360456353, 45808.312875307565, 45934.31098533458, 46165.53834461612, 46535.53464465447, 39016.41475377815, 39365.409518856664, 39413.0, 39535.2092958145, 39686.2062758749, 38507.2298554033, 39230.607693923834, 39288.803555982035, 39319.80340098281, 39449.80275098606, 36903.0, 37183.256334873695, 38297.61702383052, 38858.2228355437, 39183.608163918, 32374.35251295008, 32432.189195270308, 32515.34969300648, 32789.67210327866, 33027.33945321128, 26424.847244424043, 26521.0, 26749.0, 26861.24559037922, 26901.192964211106], "unit": "score", "name": "ext.html", "value": 18366.09523599256}, {"lowerIsBetter": false, "replicates": [325.8859399210276, 335.60231126115553, 347.18065365736857, 351.56230493036173, 355.0520111302821, 16799.412020579268, 17817.554561135963, 18325.7251141233, 18329.0, 18526.536836579093, 16848.157592120406, 17202.91398543009, 17398.30406783727, 17837.286508539644, 17846.910765446155, 5303.151495760679, 5327.227552004947, 5445.809396671118, 5454.563634909197, 5469.974542005682, 5322.121849894782, 5367.865803354928, 5379.6503227290295, 5380.650257733254, 5407.891842163154, 5241.344831896013, 5418.83743487694, 5424.701641409721, 5501.284832971708, 5510.862228444301, 5394.946050539504, 5432.972835135839, 5438.456154384569, 5449.891002179934, 5456.208849716789, 4640.141573808856, 4804.735739534324, 4809.6392770542, 4812.25410061441, 4826.638002149853, 21195.788042119537, 21741.0, 21888.0, 21975.450613734625, 22137.335879923627, 2363.444590521226, 2412.1075202175134, 2448.7061552613623, 2462.175171317611, 2575.7939364850768, 13501.32493375337, 13860.514881979083, 13883.930580347034, 14045.227512486808, 14196.148231106166, 1837.7243413488084, 1861.2275905499203, 1889.9055047247582, 1912.7991560886046, 1952.9707054394196, 58310.708446457924, 62543.6872815633, 63783.68108159476, 64153.35846641521, 64704.676476617315, 9532.475713835805, 10096.949515252376, 10457.790844183226, 10510.579576816994, 10565.20760942917, 14377.20925349095, 14388.208648524222, 14460.566183014316, 14474.565763027125, 14555.417783288762, 7622.0, 7724.188960159215, 7782.92217077822, 7799.259070388304, 7851.882221766678, 7300.233475484997, 7400.48196626231, 7480.775576732707, 7545.773626791205, 7553.962230188814, 4448.488423831301, 4478.552144785495, 4496.7077139985795, 4523.072770082125, 4584.931226031612, 1805.873588848768, 1811.1397086383863, 1828.1042289278423, 1851.3150134450339, 1876.6246750649925, 1029.527775281355, 1046.450613427941, 1060.1571750458404, 1071.8606581144402, 1102.1348241630442, 17591.82408175902, 17598.38405655796, 17602.11989400525, 17674.0, 17934.730979035325, 930.4928813796362, 931.7810314576069, 970.2868391732071, 993.2103977338033, 994.8656931314325, 10203.38779673222, 10266.486675666187, 10358.326708764056, 10375.584976600852, 10488.947555262175, 413651.0, 427355.0, 432448.0, 436629.0, 437663.0, 59623.0, 75617.62191189118, 77582.0, 78000.60999695079, 78677.0, 980.9307854438696, 991.8561808537866, 1001.6193846338344, 1009.3086235928413, 1014.4826138669184, 16200.756988645415, 16226.594335141715, 16409.835901640832, 16463.176841157656, 16651.250693718568, 23330.533389332457, 35383.64616353803, 36245.45631815472, 36312.4553131698, 36344.27311453809, 47829.0, 49721.502784971686, 50488.24267636062, 50564.74717626535, 50659.0, 7701.268379503938, 7858.096318923168, 7937.603119844101, 7939.404544659058, 7949.801254968672, 11486.94256528712, 11873.940630297138, 11918.761624767629, 12290.385480725748, 12514.124011319484, 9429.245660347018, 9857.852132217879, 9987.850182247126, 10127.392356458342, 10233.488325583543, 5172.094883395466, 7334.596597187206, 10382.948085259526, 10770.628808080219, 11109.0, 10656.467176641292, 11007.779844402907, 11111.83332250033, 11245.100391968459, 11445.141614379121, 7443.665035073326, 7719.691212351443, 7861.410394220342, 7948.324392426708, 8098.230668086522, 8200.958995204986, 10203.438810865176, 10710.518026688973, 10748.570057197625, 10753.623623173151], "unit": "score", "name": "jquery.html", "value": 8532.165460100461}, {"lowerIsBetter": false, "replicates": [1567.866731327837, 1580.8182059063208, 1825.4341154242186, 1859.4979355573987, 1901.59115790105, 7511.849763004737, 8342.37432192585, 8431.873521897176, 8637.78405539861, 8657.393982421234, 8076.313513351372, 8127.268545830874, 8175.509469431823, 8193.836123277531, 8209.425340226186, 2393.6768536247646, 2419.346776370379, 2419.9637005444933, 2421.2010036687852, 2421.2978236311446, 2316.664083707861, 2319.4549280919055, 2353.8705371204665, 2367.6330168823774, 2377.9286621401384, 2405.891734871935, 2411.4574220800355, 2417.576924038295, 2438.6829712137396, 2449.7550244975537, 2375.5486457573006, 2389.629607410854, 2394.724606670229, 2396.7483414241515, 2401.0635852017726, 2295.1507942061544, 2310.0413328468667, 2312.7455979842202, 2313.1556981701724, 2314.6990891184205, 8286.378521610903, 8328.417010809246, 8330.291925186366, 8347.666093356258, 8355.623996920152, 5152.149895267276, 5263.499967503081, 5267.3679158500845, 5272.604554658377, 5274.789008439696, 3249.0, 3280.7867488613165, 3332.783369081026, 3378.476336167898, 3421.726261899042, 1008.5411137932297, 1029.4698230411343, 1035.8394448860438, 1076.3004047369195, 1079.4656644960717, 12109.576164834276, 12160.817587736192, 12200.938995304967, 12239.0, 12244.081693872906, 4541.500434952152, 4669.182892993713, 4775.9731657693765, 4792.640551958617, 4815.662903596714, 9382.343235973416, 9390.577424015935, 9393.812123757487, 9484.620615175454, 9518.619255229713, 5204.505571970657, 5243.868903277448, 5245.921311180336, 5246.213068039825, 5250.632455728062, 4440.555944405533, 4490.348899409567, 4501.549845015537, 4506.932396014063, 4752.714837109785, 3550.7869527827897, 3581.0, 3584.462330650423, 3627.6553727395853, 3646.3801153803915, 1073.500822117719, 1076.230495195923, 1078.3260462211117, 1085.3325204998869, 1097.1113398147527, 1143.4168574027306, 1158.5597472960221, 1178.8172833210865, 1182.1665725663386, 1183.4556104192168, 8021.839563208703, 8163.10205877353, 8167.224113709188, 8219.095899451055, 8254.587270636444, 1193.1707463313087, 1215.4530461292454, 1217.689489180271, 1221.1696046688337, 1238.5603110895684, 6387.393197646216, 6390.169277993831, 6478.773242936474, 6487.124238227873, 6490.740370385226, 10239.334443261165, 10794.24440289188, 10804.351738895692, 10822.404767737693, 10846.78306433867, 10420.32267902584, 10590.046895779416, 10590.311629744043, 10592.523336449724, 10804.837927430937, 8269.421140520226, 8289.58552072394, 8402.957985210034, 8405.033421156646, 8420.0, 7968.482048666818, 8040.316573091352, 8054.275115239657, 8086.15095414973, 8095.676172953016, 9385.577649005674, 9402.623895044395, 9449.48027858447, 9468.195203407511, 9623.518824058629, 9607.759806004906, 9831.606735730491, 9856.852147217654, 9889.159421449258, 9898.851517227391, 7301.08736407949, 7418.554886706815, 7435.776926692208, 7644.961775191088, 7668.0, 8213.712520061768, 8214.63034163476, 8223.177682231968, 8249.79375515617, 8270.751877443687, 7274.236205198589, 7358.889616655862, 7457.776266712007, 7497.400207983239, 7561.3194812467145, 7245.673944672397, 7326.120865496175, 7377.4835761498325, 7418.258174182754, 7436.59098749574, 7755.612219388895, 7819.960900195462, 7842.215778422112, 7877.566733829694, 7887.881681774663, 6781.728730850711, 7059.752908648173, 7093.113360829896, 7101.680424381018, 7142.071530700976, 7178.210396856446, 7184.425245980205, 7202.639868006474, 7239.276072392719, 7245.5652660840515], "unit": "score", "name": "mootools.html", "value": 4851.5649646255015}, {"lowerIsBetter": false, "replicates": [325.58975690629813, 337.77537937271717, 344.41449535789155, 344.5245561125646, 347.5429809800111, 6265.749370025205, 6267.749290028393, 6301.968490157548, 6307.716152773125, 6331.366863313667, 6205.472534834545, 6212.937870621293, 6222.097795819604, 6224.595401298924, 6240.126382306481, 4651.325557794118, 4745.406824146981, 4768.213244814601, 4790.113828941657, 4806.086843499724, 4772.522747725217, 4775.928361074587, 4779.02030083832, 4781.569658730714, 4788.9521104788855, 4727.290906364038, 4731.763411829412, 4738.407699037621, 4750.548697873696, 4759.405074365704, 4749.833755818547, 4751.477337492873, 4759.785809638557, 4761.285807128924, 4761.857144285677, 4114.526829414625, 4114.938275925863, 4120.979395103035, 4127.195196936598, 4132.0, 5912.704364781744, 5933.703314834284, 5940.70296485174, 5947.226860508106, 5961.195238642771, 5332.813351532716, 5489.286392768954, 5492.0663487206875, 5495.422980587021, 5499.807506737245, 6627.635480048595, 6662.833429164261, 6663.0, 6665.733370665168, 6672.3661252181455, 4459.353393757887, 4459.375687403766, 4471.731696098212, 4474.373587697725, 4494.68537202396, 6934.930650693479, 6997.965010174917, 7021.368076873106, 7023.297670232936, 7046.788596342118, 4626.884327891829, 4636.675432719677, 4638.0491999140095, 4638.095571363552, 4644.233701439292, 4721.693089949143, 4820.276958456259, 4828.444728856227, 4833.806647734052, 4863.70817750929, 5522.585806064561, 5556.222128901876, 5593.8321850344555, 5597.860053498695, 5610.579206559524, 6720.227173875067, 6726.697298621574, 6751.223609284897, 6755.425788807908, 6794.946783248604, 1690.9070001150055, 1715.305301352954, 1715.845573898355, 1717.313074770077, 1719.9656006879793, 1086.1690806533009, 1119.7592517608753, 1122.0294445304917, 1127.2785417332914, 1135.500379832871, 6543.44380727634, 6560.573562718503, 6561.0, 6561.835954101186, 6571.769988050491, 6868.0, 6905.37851593359, 6930.688119034656, 6949.965250173818, 6973.755918542928, 6469.482441404676, 6567.211934567787, 6647.933520664828, 6667.833304167338, 6673.632950187689, 3781.1681430085337, 3786.8295926683363, 3800.56293526248, 3806.562245341821, 3817.1602247505502, 7338.486305958639, 7350.889736653954, 7353.338199562065, 7374.151972523121, 7382.704691812267, 7165.713371465187, 7196.172440169343, 7204.9279507204255, 7219.747308844166, 7225.421966242688, 7206.243344448862, 7351.632418379167, 7392.4086073115095, 7410.666520006613, 7412.740554080581, 6999.12510936133, 7015.508914375945, 7021.5787052777, 7036.437085033287, 7044.823879403056, 6908.723651053901, 6909.2399836019, 6910.896336555056, 6911.516193866381, 6918.584884906922, 7369.77890663281, 7384.18773934856, 7388.224236455095, 7389.150247721581, 7391.593462359622, 4508.256137737237, 4629.513901040477, 4636.721796692209, 4645.070985802786, 4650.604698600657, 6921.826954326182, 6963.895541566982, 6966.9303306966285, 6980.7905762827195, 6983.0, 6724.361185687352, 6731.32686731323, 6758.189017317954, 6768.492363072888, 6776.356246156607, 6716.328367163244, 6739.022841688025, 6758.763443279461, 6769.763058292936, 6770.1537307836525, 6490.0, 6601.207855057424, 6613.338666133348, 6621.370969757865, 6644.501662375438, 6694.933050669431, 6729.327067293231, 6738.35985581369, 6740.618173274565, 6758.5269031167345, 6564.277929427663, 6593.769218077345, 6602.161070739436, 6602.702878370581, 6618.073469714148], "unit": "score", "name": "prototype.html", "value": 5050.909546656325}, {"lowerIsBetter": false, "replicates": [876.1982785751037, 888.6578667213125, 903.4263242840798, 904.127516946147, 913.8903331600209, 14533.927330363333, 14586.270686465674, 14676.779848302283, 14824.407023719052, 14860.702785944275, 14347.928260358709, 14400.423983040666, 14448.638784030405, 14449.855501444983, 14451.638709032279, 918.3387960668308, 940.8447606144978, 943.3208090175098, 944.0606596436555, 944.315371355765, 938.737153596994, 941.472775245861, 941.6327632223438, 944.0087907696925, 945.9385139965915, 971.815355082532, 973.0172525749009, 980.0640388429068, 980.240313756837, 982.1013772398247, 963.9036096390375, 964.7877466957258, 966.5988614724915, 970.0590427285522, 987.3878195518824, 724.3770357492552, 726.0923845193508, 727.3054233207274, 727.3671905442299, 731.3600599475459, 15147.772783408258, 15300.923495382563, 15338.923305383514, 15346.232688365648, 15416.614584635361, 13957.302134893316, 14081.5071472499, 14089.0, 14101.2244326562, 14105.717885642229, 10480.161587073093, 10514.106300964428, 10568.52441640128, 11070.833937490945, 11365.829512557319, 3816.160444702161, 3862.0344913771555, 3866.4586957825927, 3866.8646597368956, 3918.960810391888, 52771.736141319045, 52782.736086319324, 52966.47033529654, 53168.46831531713, 53488.73255633736, 10401.895981040092, 10798.244122911477, 10912.236143469881, 11355.0, 11773.411329433666, 19637.60724785525, 19943.0, 19949.301774437827, 19986.000699964945, 20098.0, 8149.388795840336, 8255.545944973084, 8328.292095171857, 8330.416870819106, 8389.203025712548, 4441.666874984389, 4465.620422264144, 4599.126166028444, 4640.767961601907, 4723.834665786681, 3167.588213532226, 3216.067340471237, 3238.028591422611, 3240.206149493389, 3243.8053716777067, 603.8792241551707, 609.2506217352593, 614.3856143856144, 614.6250787019915, 617.9443850053517, 665.5540787672271, 747.3610063395719, 757.5038349880837, 764.5030730025417, 777.1800750208471, 8978.551072446351, 9000.414973026733, 9198.126178013212, 9303.348765586345, 9575.760605984768, 634.5462993959342, 683.8187880211748, 687.542784048612, 689.2142957028991, 707.0560801330282, 4370.366296886934, 4692.4603670577635, 4700.294955756595, 4797.088553174885, 4862.465128835825, 58552.0, 58856.41143588595, 61717.69141154355, 62145.067823982674, 62441.37558624447, 54293.0, 54783.0, 55658.72170639202, 56039.0, 56060.0, 48455.0, 48570.0, 48629.75685121552, 49056.26415603769, 49594.0, 9560.426374417557, 9773.31586788918, 9775.315727898978, 9807.0, 9846.064623860722, 33537.0, 35090.0, 35477.82261088678, 36008.63991360053, 36010.819945900104, 40956.38565421462, 41056.0, 43412.0, 44432.77783611061, 44767.10465790731, 11830.881691182978, 12018.0, 12291.139620226499, 12323.0, 12647.114701970773, 13401.798973015217, 13490.460381584626, 13691.794623080463, 13691.931540342634, 14189.858101418853, 12417.565385211474, 12596.685082873002, 12652.683682908, 12783.93608031954, 13186.0, 12104.818427723416, 13045.739085218433, 13047.151935124186, 13386.933065334611, 13581.796273055714, 11588.188826782045, 12913.548025819051, 12982.675433114247, 13274.867251327749, 13279.66800829987, 10202.081812636898, 10470.0, 10579.523921423708, 10981.231313807957, 11132.777344452903, 10873.456327183767, 11066.612668556561, 11125.666230013112, 11226.494807733508, 11388.430578470878], "unit": "score", "name": "yui.html", "value": 6950.054590691816}], "name": "dromaeo_css", "value": 7239.395217108433}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 104.0, 114.0, 113.0, 114.0, 122.0, 111.0, 109.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 151.0, 174.0, 132.0, 152.0, 154.0, 139.0, 174.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 163.0, 162.0, 160.0, 164.0, 162.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 76.0, 168.0, 76.0, 76.0, 73.0, 76.0, 159.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.7}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 138.0, 92.0, 92.0, 93.0, 143.0, 92.0, 91.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 61.0, 55.0, 57.0, 57.0, 56.0, 55.0, 65.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 62.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [77.0, 80.0, 79.0, 84.0, 79.0, 78.0, 78.0, 78.0, 78.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [113.0, 114.0, 129.0, 113.0, 120.0, 119.0, 121.0, 121.0, 120.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [136.0, 144.0, 165.0, 143.0, 137.0, 136.0, 145.0, 144.0, 149.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 76.0, 75.0, 72.0, 71.0, 70.0, 72.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.5}], "name": "kraken", "value": 1518.7}]} 22:59:11 INFO - Return code: 0 22:59:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:59:11 ERROR - # TBPL SUCCESS # 22:59:11 INFO - Running post-action listener: _resource_record_post_action 22:59:11 INFO - Running post-run listener: _resource_record_post_run 22:59:12 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 7577600; Write bytes: 364908544; Read time: 1496; Write time: 322196 22:59:12 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 19943424; Read time: 0; Write time: 18652 22:59:12 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 7577600; Write bytes: 344965120; Read time: 1496; Write time: 303544 22:59:12 INFO - Running post-run listener: _upload_blobber_files 22:59:12 INFO - Blob upload gear active. 22:59:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:59:12 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 22:59:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:59:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:59:12 INFO - (blobuploader) - INFO - Open directory for files ... 22:59:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:59:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:59:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:59:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:59:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:59:13 INFO - (blobuploader) - INFO - Done attempting. 22:59:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:59:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:59:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:59:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:59:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:59:14 INFO - (blobuploader) - INFO - Done attempting. 22:59:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:59:14 INFO - Return code: 0 22:59:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:59:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:59:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97f16a81f9aed425d54cb6940742909a413c66eef799691e3e4dd19206bf18dd41d865b97926620d1e03123aec9f997504c37bf9a42698c1ca36d0f7093f580b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f8fad900d243e0c13cb073f14a02fad816db7648da9a88d0285243e29bbb5db4fc45e322ec74f3a7f47fe8acde5f5ab810fa02f394f5b466886a77a6cc69004"} 22:59:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:59:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:59:14 INFO - Contents: 22:59:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97f16a81f9aed425d54cb6940742909a413c66eef799691e3e4dd19206bf18dd41d865b97926620d1e03123aec9f997504c37bf9a42698c1ca36d0f7093f580b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f8fad900d243e0c13cb073f14a02fad816db7648da9a88d0285243e29bbb5db4fc45e322ec74f3a7f47fe8acde5f5ab810fa02f394f5b466886a77a6cc69004"} 22:59:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:59:14 INFO - Copying logs to upload dir... 22:59:14 INFO - mkdir: /builds/slave/test/build/upload/logs 22:59:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.485394 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-17 22:59:14.552814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 22:59:14.555896) ========= 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=62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97f16a81f9aed425d54cb6940742909a413c66eef799691e3e4dd19206bf18dd41d865b97926620d1e03123aec9f997504c37bf9a42698c1ca36d0f7093f580b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f8fad900d243e0c13cb073f14a02fad816db7648da9a88d0285243e29bbb5db4fc45e322ec74f3a7f47fe8acde5f5ab810fa02f394f5b466886a77a6cc69004"} build_url:https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/a1llmVUDQIGmAGikjVVkdw/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97f16a81f9aed425d54cb6940742909a413c66eef799691e3e4dd19206bf18dd41d865b97926620d1e03123aec9f997504c37bf9a42698c1ca36d0f7093f580b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f8fad900d243e0c13cb073f14a02fad816db7648da9a88d0285243e29bbb5db4fc45e322ec74f3a7f47fe8acde5f5ab810fa02f394f5b466886a77a6cc69004"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 22:59:14.584233) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:59:14.584678) ========= 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=62c568580acbfdaac3eec7be000001dc-1463547417.812157-517945043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 22:59:14.671947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 22:59:14.672740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 22:59:14.673255) ========= ========= Total master_lag: 0.17 =========