builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1463826753.11 results: success (0) buildid: 20160521004015 builduid: 16b1b2ee1cdb45d6bdd1dd0861d9f51f revision: 8b81a6c988c496aaff85df718646e17239c1e278 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.112332) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.112791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.113072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.130569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.130877) ========= 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=d2a8c569965ab8367867b893000001a1-1463823591.129375-724249020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 03:32: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% 46.0M=0s 2016-05-21 03:32:34 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.350011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.494219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.494560) ========= 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=d2a8c569965ab8367867b893000001a1-1463823591.129375-724249020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017856 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:33.544380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-21 03:32:33.544757) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8b81a6c988c496aaff85df718646e17239c1e278 --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-aurora --rev 8b81a6c988c496aaff85df718646e17239c1e278 --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=d2a8c569965ab8367867b893000001a1-1463823591.129375-724249020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 03:32:34,364 truncating revision to first 12 chars 2016-05-21 03:32:34,365 Setting DEBUG logging. 2016-05-21 03:32:34,365 attempt 1/10 2016-05-21 03:32:34,365 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8b81a6c988c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 03:32:35,092 unpacking tar archive at: mozilla-aurora-8b81a6c988c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.031775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-21 03:32:34.589208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:34.589516) ========= script_repo_revision: 8b81a6c988c496aaff85df718646e17239c1e278 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:34.589951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:34.590222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 03:32:34.604319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-21 03:32:34.604612) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=d2a8c569965ab8367867b893000001a1-1463823591.129375-724249020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:35 INFO - MultiFileLogger online at 20160521 03:32:35 in /builds/slave/test 03:32:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:35 INFO - {'append_to_log': False, 03:32:35 INFO - 'base_work_dir': '/builds/slave/test', 03:32:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:35 INFO - 'branch': 'Mozilla-Aurora', 03:32:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:35 INFO - 'config_files': ('talos/linux_config.py',), 03:32:35 INFO - 'default_actions': ('clobber', 03:32:35 INFO - 'read-buildbot-config', 03:32:35 INFO - 'download-and-extract', 03:32:35 INFO - 'populate-webroot', 03:32:35 INFO - 'create-virtualenv', 03:32:35 INFO - 'install', 03:32:35 INFO - 'run-tests'), 03:32:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:35 INFO - 'download_minidump_stackwalk': True, 03:32:35 INFO - 'download_symbols': 'ondemand', 03:32:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:35 INFO - 'installer_path': 'installer.exe', 03:32:35 INFO - 'log_level': 'info', 03:32:35 INFO - 'log_name': 'talos', 03:32:35 INFO - 'log_to_console': True, 03:32:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:35 INFO - 'opt_config_files': (), 03:32:35 INFO - 'pip_index': False, 03:32:35 INFO - 'sps_profile': False, 03:32:35 INFO - 'sps_profile_interval': 0, 03:32:35 INFO - 'suite': 'dromaeojs-e10s', 03:32:35 INFO - 'system_bits': '32', 03:32:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:35 INFO - 'title': 'talos-linux64-ix-043', 03:32:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:35 INFO - 'use_talos_json': True, 03:32:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:35 INFO - 'work_dir': 'build'} 03:32:35 INFO - ##### 03:32:35 INFO - ##### Running clobber step. 03:32:35 INFO - ##### 03:32:35 INFO - Running pre-action listener: _resource_record_pre_action 03:32:35 INFO - Running main action method: clobber 03:32:35 INFO - rmtree: /builds/slave/test/build 03:32:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:35 INFO - Running post-action listener: _resource_record_post_action 03:32:35 INFO - ##### 03:32:35 INFO - ##### Running read-buildbot-config step. 03:32:35 INFO - ##### 03:32:35 INFO - Running pre-action listener: _resource_record_pre_action 03:32:35 INFO - Running main action method: read_buildbot_config 03:32:35 INFO - Using buildbot properties: 03:32:35 INFO - { 03:32:35 INFO - "project": "", 03:32:35 INFO - "product": "firefox", 03:32:35 INFO - "script_repo_revision": "production", 03:32:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:32:35 INFO - "repository": "", 03:32:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:32:35 INFO - "buildid": "20160521004015", 03:32:35 INFO - "stage_platform": "linux64-pgo", 03:32:35 INFO - "basedir": "/builds/slave/test", 03:32:35 INFO - "nightly_build": "True", 03:32:35 INFO - "buildnumber": 323, 03:32:35 INFO - "slavename": "talos-linux64-ix-043", 03:32:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:32:35 INFO - "platform": "ubuntu64_hw", 03:32:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:35 INFO - "branch": "mozilla-aurora", 03:32:35 INFO - "repo_path": "releases/mozilla-aurora", 03:32:35 INFO - "revision": "8b81a6c988c496aaff85df718646e17239c1e278", 03:32:35 INFO - "pgo_build": "True", 03:32:35 INFO - "builduid": "16b1b2ee1cdb45d6bdd1dd0861d9f51f", 03:32:35 INFO - "slavebuilddir": "test" 03:32:35 INFO - } 03:32:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:32:35 INFO - Running post-action listener: _resource_record_post_action 03:32:35 INFO - ##### 03:32:35 INFO - ##### Running download-and-extract step. 03:32:35 INFO - ##### 03:32:35 INFO - Running pre-action listener: _resource_record_pre_action 03:32:35 INFO - Running main action method: download_and_extract 03:32:35 INFO - mkdir: /builds/slave/test/build/tests 03:32:35 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')]} 03:32:35 INFO - https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:32:41 INFO - Downloaded 1361 bytes. 03:32:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:32:41 INFO - Using the following test package requirements: 03:32:41 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:41 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:41 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:32:41 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'jsshell-linux-x86_64.zip'], 03:32:41 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:41 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:32:41 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:32:41 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:32:41 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:41 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:32:41 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:41 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:41 INFO - https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:46 INFO - Downloaded 23813542 bytes. 03:32:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:47 INFO - Return code: 0 03:32:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:32:47 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')]} 03:32:47 INFO - https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:32:49 INFO - Downloaded 23813542 bytes. 03:32:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:32:50 INFO - Return code: 0 03:32:50 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')]} 03:32:50 INFO - https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:32:55 INFO - Downloaded 10840145 bytes. 03:32:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:32:55 INFO - Return code: 0 03:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:55 INFO - https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:32:56 INFO - Downloaded 62721582 bytes. 03:32:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:56 INFO - mkdir: /builds/slave/test/properties 03:32:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:56 INFO - Contents: 03:32:56 INFO - build_url:https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:32:57 INFO - Running post-action listener: _resource_record_post_action 03:32:57 INFO - Running post-action listener: set_extra_try_arguments 03:32:57 INFO - ##### 03:32:57 INFO - ##### Running populate-webroot step. 03:32:57 INFO - ##### 03:32:57 INFO - Running pre-action listener: _resource_record_pre_action 03:32:57 INFO - Running main action method: populate_webroot 03:32:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:57 INFO - '--tppagecycles', 03:32:57 INFO - '7'], 03:32:57 INFO - 'tests': ['tsvgm']}}, 03:32:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['damp', 'tps']}, 03:32:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'tests': ['damp', 'tps']}, 03:32:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['dromaeo_dom']}, 03:32:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['a11yr', 03:32:57 INFO - 'ts_paint', 03:32:57 INFO - 'tpaint', 03:32:57 INFO - 'sessionrestore', 03:32:57 INFO - 'sessionrestore_no_auto_restore', 03:32:57 INFO - 'tabpaint']}, 03:32:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tsvgx', 03:32:57 INFO - 'tsvgr_opacity', 03:32:57 INFO - 'tart', 03:32:57 INFO - 'tscrollx', 03:32:57 INFO - 'cart']}, 03:32:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:57 INFO - 'tsvgr_opacity', 03:32:57 INFO - 'tart', 03:32:57 INFO - 'tscrollx', 03:32:57 INFO - 'cart']}, 03:32:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s'], 03:32:57 INFO - 'tests': ['tp5o']}, 03:32:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'tests': ['tp5o']}, 03:32:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--disable-e10s', 03:32:57 INFO - '--xperf_path', 03:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:57 INFO - 'tests': ['tp5n']}, 03:32:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:57 INFO - 'talos_options': ['--xperf_path', 03:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:57 INFO - 'tests': ['tp5n']}}, 03:32:57 INFO - 'talos.zip': {'path': '', 03:32:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:57 INFO - Running post-action listener: _resource_record_post_action 03:32:57 INFO - ##### 03:32:57 INFO - ##### Running create-virtualenv step. 03:32:57 INFO - ##### 03:32:57 INFO - Running pre-action listener: _resource_record_pre_action 03:32:57 INFO - Running main action method: create_virtualenv 03:32:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:57 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 03:32:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:57 INFO - Using real prefix '/usr' 03:32:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:57 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:59 INFO - Installing pip.................done. 03:32:59 INFO - Return code: 0 03:32:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:59 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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:32:59 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 03:32:59 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 03:32:59 INFO - Using env: {'DISPLAY': ':0', 03:32:59 INFO - 'HOME': '/home/cltbld', 03:32:59 INFO - 'LANG': 'en_US.UTF-8', 03:32:59 INFO - 'LANGUAGE': 'en_US:en', 03:32:59 INFO - 'LOGNAME': 'cltbld', 03:32:59 INFO - 'MAIL': '/var/mail/cltbld', 03:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:59 INFO - 'MOZ_NO_REMOTE': '1', 03:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:59 INFO - 'NO_EM_RESTART': '1', 03:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:59 INFO - 'PWD': '/builds/slave/test', 03:32:59 INFO - 'SHELL': '/bin/bash', 03:32:59 INFO - 'SHLVL': '1', 03:32:59 INFO - 'TERM': 'linux', 03:32:59 INFO - 'TMOUT': '86400', 03:32:59 INFO - 'USER': 'cltbld', 03:32:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:59 INFO - '_': '/tools/buildbot/bin/python'} 03:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:00 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 03:33:00 INFO - Cleaning up... 03:33:00 INFO - Return code: 0 03:33:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:33:00 INFO - Using env: {'DISPLAY': ':0', 03:33:00 INFO - 'HOME': '/home/cltbld', 03:33:00 INFO - 'LANG': 'en_US.UTF-8', 03:33:00 INFO - 'LANGUAGE': 'en_US:en', 03:33:00 INFO - 'LOGNAME': 'cltbld', 03:33:00 INFO - 'MAIL': '/var/mail/cltbld', 03:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:00 INFO - 'MOZ_NO_REMOTE': '1', 03:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:00 INFO - 'NO_EM_RESTART': '1', 03:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:00 INFO - 'PWD': '/builds/slave/test', 03:33:00 INFO - 'SHELL': '/bin/bash', 03:33:00 INFO - 'SHLVL': '1', 03:33:00 INFO - 'TERM': 'linux', 03:33:00 INFO - 'TMOUT': '86400', 03:33:00 INFO - 'USER': 'cltbld', 03:33:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:00 INFO - '_': '/tools/buildbot/bin/python'} 03:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:00 INFO - Downloading/unpacking psutil>=0.7.1 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:02 INFO - Installing collected packages: psutil 03:33:02 INFO - Running setup.py install for psutil 03:33:02 INFO - building 'psutil._psutil_linux' extension 03:33:02 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 03:33:02 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 03:33:02 INFO - building 'psutil._psutil_posix' extension 03:33:02 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 03:33:02 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 03:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:02 INFO - Successfully installed psutil 03:33:02 INFO - Cleaning up... 03:33:02 INFO - Return code: 0 03:33:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:33:02 INFO - Using env: {'DISPLAY': ':0', 03:33:02 INFO - 'HOME': '/home/cltbld', 03:33:02 INFO - 'LANG': 'en_US.UTF-8', 03:33:02 INFO - 'LANGUAGE': 'en_US:en', 03:33:02 INFO - 'LOGNAME': 'cltbld', 03:33:02 INFO - 'MAIL': '/var/mail/cltbld', 03:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:02 INFO - 'MOZ_NO_REMOTE': '1', 03:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:02 INFO - 'NO_EM_RESTART': '1', 03:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:02 INFO - 'PWD': '/builds/slave/test', 03:33:02 INFO - 'SHELL': '/bin/bash', 03:33:02 INFO - 'SHLVL': '1', 03:33:02 INFO - 'TERM': 'linux', 03:33:02 INFO - 'TMOUT': '86400', 03:33:02 INFO - 'USER': 'cltbld', 03:33:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:02 INFO - '_': '/tools/buildbot/bin/python'} 03:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:33:05 INFO - Installing collected packages: mozsystemmonitor 03:33:05 INFO - Running setup.py install for mozsystemmonitor 03:33:05 INFO - Successfully installed mozsystemmonitor 03:33:05 INFO - Cleaning up... 03:33:05 INFO - Return code: 0 03:33:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:33:05 INFO - Using env: {'DISPLAY': ':0', 03:33:05 INFO - 'HOME': '/home/cltbld', 03:33:05 INFO - 'LANG': 'en_US.UTF-8', 03:33:05 INFO - 'LANGUAGE': 'en_US:en', 03:33:05 INFO - 'LOGNAME': 'cltbld', 03:33:05 INFO - 'MAIL': '/var/mail/cltbld', 03:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:05 INFO - 'MOZ_NO_REMOTE': '1', 03:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:05 INFO - 'NO_EM_RESTART': '1', 03:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:05 INFO - 'PWD': '/builds/slave/test', 03:33:05 INFO - 'SHELL': '/bin/bash', 03:33:05 INFO - 'SHLVL': '1', 03:33:05 INFO - 'TERM': 'linux', 03:33:05 INFO - 'TMOUT': '86400', 03:33:05 INFO - 'USER': 'cltbld', 03:33:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:05 INFO - '_': '/tools/buildbot/bin/python'} 03:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:07 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:07 INFO - Downloading docopt-0.6.1.tar.gz 03:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:07 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:07 INFO - Running setup.py install for blobuploader 03:33:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:08 INFO - Running setup.py install for requests 03:33:08 INFO - Running setup.py install for docopt 03:33:08 INFO - Successfully installed blobuploader requests docopt 03:33:08 INFO - Cleaning up... 03:33:08 INFO - Return code: 0 03:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:08 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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:08 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 03:33:08 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 03:33:08 INFO - Using env: {'DISPLAY': ':0', 03:33:08 INFO - 'HOME': '/home/cltbld', 03:33:08 INFO - 'LANG': 'en_US.UTF-8', 03:33:08 INFO - 'LANGUAGE': 'en_US:en', 03:33:08 INFO - 'LOGNAME': 'cltbld', 03:33:08 INFO - 'MAIL': '/var/mail/cltbld', 03:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:08 INFO - 'MOZ_NO_REMOTE': '1', 03:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:08 INFO - 'NO_EM_RESTART': '1', 03:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:08 INFO - 'PWD': '/builds/slave/test', 03:33:08 INFO - 'SHELL': '/bin/bash', 03:33:08 INFO - 'SHLVL': '1', 03:33:08 INFO - 'TERM': 'linux', 03:33:08 INFO - 'TMOUT': '86400', 03:33:08 INFO - 'USER': 'cltbld', 03:33:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:08 INFO - '_': '/tools/buildbot/bin/python'} 03:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:08 INFO - Running setup.py (path:/tmp/pip-7diuLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:08 INFO - Running setup.py (path:/tmp/pip-0QFfMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:08 INFO - Running setup.py (path:/tmp/pip-YNQdbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:09 INFO - Running setup.py (path:/tmp/pip-Qr1NtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:09 INFO - Running setup.py (path:/tmp/pip-mFcOP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:09 INFO - Running setup.py (path:/tmp/pip-WWdT27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:09 INFO - Running setup.py (path:/tmp/pip-iLQxoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:09 INFO - Running setup.py (path:/tmp/pip-cvXLSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:09 INFO - Running setup.py (path:/tmp/pip-mpEvs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:09 INFO - Running setup.py (path:/tmp/pip-sadh9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:09 INFO - Running setup.py (path:/tmp/pip-4MWYHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:09 INFO - Running setup.py (path:/tmp/pip-27PE29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:09 INFO - Running setup.py (path:/tmp/pip-CWeLu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:09 INFO - Running setup.py (path:/tmp/pip-hkkis_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:09 INFO - Running setup.py (path:/tmp/pip-0Izn7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:09 INFO - Running setup.py (path:/tmp/pip-MNXlgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:09 INFO - Running setup.py (path:/tmp/pip-yWq4wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:09 INFO - Running setup.py install for manifestparser 03:33:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Running setup.py install for mozcrash 03:33:10 INFO - Running setup.py install for mozdebug 03:33:10 INFO - Running setup.py install for mozdevice 03:33:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Running setup.py install for mozfile 03:33:10 INFO - Running setup.py install for mozhttpd 03:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Running setup.py install for mozinfo 03:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Running setup.py install for mozInstall 03:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:10 INFO - Running setup.py install for mozleak 03:33:10 INFO - Running setup.py install for mozlog 03:33:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Running setup.py install for moznetwork 03:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Running setup.py install for mozprocess 03:33:11 INFO - Running setup.py install for mozprofile 03:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Running setup.py install for mozrunner 03:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Running setup.py install for mozscreenshot 03:33:11 INFO - Running setup.py install for moztest 03:33:11 INFO - Running setup.py install for mozversion 03:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:11 INFO - Cleaning up... 03:33:11 INFO - Return code: 0 03:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:11 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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:11 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 03:33:11 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 03:33:11 INFO - Using env: {'DISPLAY': ':0', 03:33:11 INFO - 'HOME': '/home/cltbld', 03:33:11 INFO - 'LANG': 'en_US.UTF-8', 03:33:11 INFO - 'LANGUAGE': 'en_US:en', 03:33:11 INFO - 'LOGNAME': 'cltbld', 03:33:11 INFO - 'MAIL': '/var/mail/cltbld', 03:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:11 INFO - 'MOZ_NO_REMOTE': '1', 03:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:11 INFO - 'NO_EM_RESTART': '1', 03:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:11 INFO - 'PWD': '/builds/slave/test', 03:33:11 INFO - 'SHELL': '/bin/bash', 03:33:11 INFO - 'SHLVL': '1', 03:33:11 INFO - 'TERM': 'linux', 03:33:11 INFO - 'TMOUT': '86400', 03:33:11 INFO - 'USER': 'cltbld', 03:33:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:11 INFO - '_': '/tools/buildbot/bin/python'} 03:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:12 INFO - Running setup.py (path:/tmp/pip-fVUx5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:12 INFO - Running setup.py (path:/tmp/pip-4LMi0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:12 INFO - Running setup.py (path:/tmp/pip-MRX7G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:12 INFO - Running setup.py (path:/tmp/pip-1Y2sXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:12 INFO - Running setup.py (path:/tmp/pip-7bINPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:12 INFO - Running setup.py (path:/tmp/pip-1QASj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:12 INFO - Running setup.py (path:/tmp/pip-ubE15N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:12 INFO - Running setup.py (path:/tmp/pip-lGRk2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:12 INFO - Running setup.py (path:/tmp/pip-IR_HLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:12 INFO - Running setup.py (path:/tmp/pip-R9kL9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:12 INFO - Running setup.py (path:/tmp/pip-zZu8Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:12 INFO - Running setup.py (path:/tmp/pip-HfxVOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:12 INFO - Running setup.py (path:/tmp/pip-nRd6RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:12 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)) 03:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:12 INFO - Running setup.py (path:/tmp/pip-Druwii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:13 INFO - Running setup.py (path:/tmp/pip-SHlctS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:13 INFO - Running setup.py (path:/tmp/pip-hz3V_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:13 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)) 03:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:13 INFO - Running setup.py (path:/tmp/pip-SH4D0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:13 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)) 03:33:13 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)) 03:33:13 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)) 03:33:13 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)) 03:33:13 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)) 03:33:13 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)) 03:33:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:15 INFO - Downloading blessings-1.6.tar.gz 03:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:15 INFO - Installing collected packages: blessings 03:33:15 INFO - Running setup.py install for blessings 03:33:15 INFO - Successfully installed blessings 03:33:15 INFO - Cleaning up... 03:33:15 INFO - Return code: 0 03:33:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:15 INFO - Reading from file tmpfile_stdout 03:33:15 INFO - Current package versions: 03:33:15 INFO - argparse == 1.2.1 03:33:15 INFO - blessings == 1.6 03:33:15 INFO - blobuploader == 1.2.4 03:33:15 INFO - docopt == 0.6.1 03:33:15 INFO - manifestparser == 1.1 03:33:15 INFO - mozInstall == 1.12 03:33:15 INFO - mozcrash == 0.17 03:33:15 INFO - mozdebug == 0.1 03:33:15 INFO - mozdevice == 0.48 03:33:15 INFO - mozfile == 1.2 03:33:15 INFO - mozhttpd == 0.7 03:33:15 INFO - mozinfo == 0.9 03:33:15 INFO - mozleak == 0.1 03:33:15 INFO - mozlog == 3.1 03:33:15 INFO - moznetwork == 0.27 03:33:15 INFO - mozprocess == 0.22 03:33:15 INFO - mozprofile == 0.28 03:33:15 INFO - mozrunner == 6.11 03:33:15 INFO - mozscreenshot == 0.1 03:33:15 INFO - mozsystemmonitor == 0.0 03:33:15 INFO - moztest == 0.7 03:33:15 INFO - mozversion == 1.4 03:33:15 INFO - psutil == 3.1.1 03:33:15 INFO - requests == 1.2.3 03:33:15 INFO - wsgiref == 0.1.2 03:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:15 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')]} 03:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:15 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')]} 03:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:15 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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:15 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 03:33:15 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 03:33:15 INFO - Using env: {'DISPLAY': ':0', 03:33:15 INFO - 'HOME': '/home/cltbld', 03:33:15 INFO - 'LANG': 'en_US.UTF-8', 03:33:15 INFO - 'LANGUAGE': 'en_US:en', 03:33:15 INFO - 'LOGNAME': 'cltbld', 03:33:15 INFO - 'MAIL': '/var/mail/cltbld', 03:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:15 INFO - 'MOZ_NO_REMOTE': '1', 03:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:15 INFO - 'NO_EM_RESTART': '1', 03:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:15 INFO - 'PWD': '/builds/slave/test', 03:33:15 INFO - 'SHELL': '/bin/bash', 03:33:15 INFO - 'SHLVL': '1', 03:33:15 INFO - 'TERM': 'linux', 03:33:15 INFO - 'TMOUT': '86400', 03:33:15 INFO - 'USER': 'cltbld', 03:33:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:15 INFO - '_': '/tools/buildbot/bin/python'} 03:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 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)) 03:33:15 INFO - Cleaning up... 03:33:15 INFO - Return code: 0 03:33:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:15 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')]} 03:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:15 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')]} 03:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:15 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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:15 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 03:33:15 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 03:33:15 INFO - Using env: {'DISPLAY': ':0', 03:33:15 INFO - 'HOME': '/home/cltbld', 03:33:15 INFO - 'LANG': 'en_US.UTF-8', 03:33:15 INFO - 'LANGUAGE': 'en_US:en', 03:33:15 INFO - 'LOGNAME': 'cltbld', 03:33:15 INFO - 'MAIL': '/var/mail/cltbld', 03:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:15 INFO - 'MOZ_NO_REMOTE': '1', 03:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:15 INFO - 'NO_EM_RESTART': '1', 03:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:15 INFO - 'PWD': '/builds/slave/test', 03:33:15 INFO - 'SHELL': '/bin/bash', 03:33:15 INFO - 'SHLVL': '1', 03:33:15 INFO - 'TERM': 'linux', 03:33:15 INFO - 'TMOUT': '86400', 03:33:15 INFO - 'USER': 'cltbld', 03:33:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:15 INFO - '_': '/tools/buildbot/bin/python'} 03:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:16 INFO - Downloading/unpacking jsonschema 03:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:17 INFO - Downloading/unpacking functools32 (from jsonschema) 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:17 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 03:33:18 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:18 INFO - warning: no files found matching '*.txt' 03:33:18 INFO - no previously-included directories found matching 'build' 03:33:18 INFO - no previously-included directories found matching 'dist' 03:33:18 INFO - no previously-included directories found matching '.git*' 03:33:18 INFO - Installing collected packages: jsonschema, functools32 03:33:18 INFO - Running setup.py install for functools32 03:33:18 INFO - warning: no files found matching '*.txt' 03:33:18 INFO - no previously-included directories found matching 'build' 03:33:18 INFO - no previously-included directories found matching 'dist' 03:33:18 INFO - no previously-included directories found matching '.git*' 03:33:18 INFO - Successfully installed jsonschema functools32 03:33:18 INFO - Cleaning up... 03:33:18 INFO - Return code: 0 03:33:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:18 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 0x7f0fea83df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, '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': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', '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 03:33:18 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 03:33:18 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 03:33:18 INFO - Using env: {'DISPLAY': ':0', 03:33:18 INFO - 'HOME': '/home/cltbld', 03:33:18 INFO - 'LANG': 'en_US.UTF-8', 03:33:18 INFO - 'LANGUAGE': 'en_US:en', 03:33:18 INFO - 'LOGNAME': 'cltbld', 03:33:18 INFO - 'MAIL': '/var/mail/cltbld', 03:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:18 INFO - 'MOZ_NO_REMOTE': '1', 03:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:18 INFO - 'NO_EM_RESTART': '1', 03:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:18 INFO - 'PWD': '/builds/slave/test', 03:33:18 INFO - 'SHELL': '/bin/bash', 03:33:18 INFO - 'SHLVL': '1', 03:33:18 INFO - 'TERM': 'linux', 03:33:18 INFO - 'TMOUT': '86400', 03:33:18 INFO - 'USER': 'cltbld', 03:33:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:18 INFO - '_': '/tools/buildbot/bin/python'} 03:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:18 INFO - Downloading/unpacking flake8 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:33:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:33:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:20 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 03:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:33:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:21 INFO - no previously-included directories found matching 'docs/_build' 03:33:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:33:21 INFO - Running setup.py install for pep8 03:33:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:21 INFO - no previously-included directories found matching 'docs/_build' 03:33:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:33:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:33:21 INFO - Cleaning up... 03:33:21 INFO - Return code: 0 03:33:21 INFO - Running post-action listener: _resource_record_post_action 03:33:21 INFO - Running post-action listener: _start_resource_monitoring 03:33:21 INFO - Starting resource monitoring. 03:33:21 INFO - ##### 03:33:21 INFO - ##### Running install step. 03:33:21 INFO - ##### 03:33:21 INFO - Running pre-action listener: _resource_record_pre_action 03:33:21 INFO - Running main action method: install 03:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:21 INFO - Reading from file tmpfile_stdout 03:33:21 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:21 INFO - Reading from file tmpfile_stdout 03:33:21 INFO - Output received: 03:33:21 INFO - Usage: mozinstall [options] installer 03:33:21 INFO - Options: 03:33:21 INFO - -h, --help show this help message and exit 03:33:21 INFO - -d DEST, --destination=DEST 03:33:21 INFO - Directory to install application into. [default: 03:33:21 INFO - "/builds/slave/test"] 03:33:21 INFO - --app=APP Application being installed. [default: firefox] 03:33:21 INFO - mkdir: /builds/slave/test/build/application 03:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:33:37 INFO - Reading from file tmpfile_stdout 03:33:37 INFO - Output received: 03:33:37 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:37 INFO - Running post-action listener: _resource_record_post_action 03:33:37 INFO - ##### 03:33:37 INFO - ##### Running run-tests step. 03:33:37 INFO - ##### 03:33:37 INFO - Running pre-action listener: _resource_record_pre_action 03:33:37 INFO - Running main action method: run_tests 03:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:37 INFO - Python 2.7.3 03:33:37 INFO - Return code: 0 03:33:37 INFO - grabbing minidump binary from tooltool 03:33:37 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')]} 03:33:37 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 0x1337410>, '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 0x1338310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13387a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:37 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 03:33:37 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 03:33:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:37 INFO - Return code: 0 03:33:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:38 INFO - Return code: 0 03:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 03:33:38 INFO - Using env: {'DISPLAY': ':0', 03:33:38 INFO - 'HOME': '/home/cltbld', 03:33:38 INFO - 'LANG': 'en_US.UTF-8', 03:33:38 INFO - 'LANGUAGE': 'en_US:en', 03:33:38 INFO - 'LOGNAME': 'cltbld', 03:33:38 INFO - 'MAIL': '/var/mail/cltbld', 03:33:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:38 INFO - 'MOZ_NO_REMOTE': '1', 03:33:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:38 INFO - 'NO_EM_RESTART': '1', 03:33:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:38 INFO - 'PWD': '/builds/slave/test', 03:33:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:38 INFO - 'SHELL': '/bin/bash', 03:33:38 INFO - 'SHLVL': '1', 03:33:38 INFO - 'TERM': 'linux', 03:33:38 INFO - 'TMOUT': '86400', 03:33:38 INFO - 'USER': 'cltbld', 03:33:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1463823591.129375-724249020', 03:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:38 INFO - '_': '/tools/buildbot/bin/python'} 03:33:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 03:33:38 INFO - mozversion application_buildid: 20160521004015 03:33:38 INFO - mozversion application_changeset: 8b81a6c988c496aaff85df718646e17239c1e278 03:33:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:33:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:38 INFO - mozversion application_name: Firefox 03:33:38 INFO - mozversion application_remotingname: firefox-dev 03:33:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:38 INFO - mozversion application_vendor: Mozilla 03:33:38 INFO - mozversion application_version: 48.0a2 03:33:38 INFO - mozversion platform_buildid: 20160521004015 03:33:38 INFO - mozversion platform_changeset: 8b81a6c988c496aaff85df718646e17239c1e278 03:33:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:33:38 INFO - mozversion platform_version: 48.0a2 03:33:38 INFO - using testdate: 1463826818 03:33:38 INFO - actual date: 1463826818 03:33:38 INFO - starting webserver on 'localhost:42720' 03:33:38 INFO - SUITE-START | Running 2 tests 03:33:38 INFO - TEST-START | dromaeo_css 03:33:38 INFO - operating with platform_type : linux_ 03:33:38 INFO - Initialising browser for dromaeo_css test... 03:33:38 INFO - TEST-INFO | started process 30675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsdQwqm/profile http://localhost:42720/getInfo.html) 03:33:42 INFO - PROCESS | 30675 | 03:33:42 INFO - PROCESS | 30675 | (process:30754): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:33:43 INFO - PROCESS | 30675 | __metrics Screen width/height:1600/1200 03:33:43 INFO - PROCESS | 30675 | colorDepth:24 03:33:43 INFO - PROCESS | 30675 | Browser inner width/height: 1024/697 03:33:43 INFO - PROCESS | 30675 | __metrics 03:33:44 ERROR - PROCESS | 30675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:33:44 INFO - TEST-INFO | 30675: exit 0 03:33:44 INFO - Browser initialized. 03:33:44 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:44 INFO - TEST-INFO | started process 30806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsdQwqm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:46 INFO - PROCESS | 30806 | 03:33:46 INFO - PROCESS | 30806 | (process:30874): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:33:56 INFO - PROCESS | 30806 | RSS: Main: 151937024 03:33:56 INFO - PROCESS | 30806 | 03:34:46 INFO - PROCESS | 30806 | 1463826886411 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] 03:36:53 INFO - PROCESS | 30806 | Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42720/tests/dromaeo/cssquery-ext.html) 03:36:54 INFO - PROCESS | 30806 | RSS: Main: 156151808 03:36:54 INFO - PROCESS | 30806 | 03:39:56 INFO - PROCESS | 30806 | Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-ext.html (next: http://localhost:42720/tests/dromaeo/cssquery-jquery.html) 03:39:57 INFO - PROCESS | 30806 | RSS: Main: 153513984 03:39:57 INFO - PROCESS | 30806 | 03:42:59 INFO - PROCESS | 30806 | Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42720/tests/dromaeo/cssquery-mootools.html) 03:42:59 INFO - PROCESS | 30806 | RSS: Main: 153399296 03:42:59 INFO - PROCESS | 30806 | 03:46:01 INFO - PROCESS | 30806 | Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42720/tests/dromaeo/cssquery-prototype.html) 03:46:01 INFO - PROCESS | 30806 | RSS: Main: 153387008 03:46:01 INFO - PROCESS | 30806 | 03:49:04 INFO - PROCESS | 30806 | Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42720/tests/dromaeo/cssquery-yui.html) 03:49:04 INFO - PROCESS | 30806 | RSS: Main: 154730496 03:49:04 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | Cycle 1(1): loaded http://localhost:42720/tests/dromaeo/cssquery-yui.html (next: http://localhost:42720/tests/dromaeo/cssquery-dojo.html) 03:52:07 INFO - PROCESS | 30806 | RSS: Main: 156225536 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | __start_tp_report 03:52:07 INFO - PROCESS | 30806 | _x_x_mozilla_page_load 03:52:07 INFO - PROCESS | 30806 | _x_x_mozilla_page_load_details 03:52:07 INFO - PROCESS | 30806 | |i|pagename|runs| 03:52:07 INFO - PROCESS | 30806 | |0;dojo.html;3328.5672862527877;3350.514175444561;3406.8807591734294;3411.3688967541007;3424.8458819353127;5546.722663866811;5555.166724991253;5566.304211973504;5587.83236502905;5587.9662262481415;5551.72241387931;5573.693446860421;5576.191452239423;5593.580481463896;5614.522765564921;5023.37207849018;5032.698038117706;5109.744512774365;5110.897782044357;5134.820281290155;4977.576905962997;5112.8977420451565;5203.4536373680785;5214.165733482643;5218.086834803913;5033.421156567005;5069.619778516608;5100.489951004907;5158;5189.351331083614;5098.745062746848;5102.081625307444;5159.097157997336;5160.432352441228;5161.406438259611;5011.373578302712;5089.6691715038405;5125.974370128163;5135.743212839343;5161.561267292284;5341.359036915556;5482.616216864821;5511.862203444906;5528.198411230349;5529.447055294479;5896.233489646362;5931.762729490858;5937.198478205431;5939.703014849283;5945.048792193272;5796.594238403313;5998.8500287492725;6000.729967151488;6025.668588227646;6028.517718582503;5538.889222215574;5557.833265002016;5568.554515638739;5652.773889044433;5730.255066841326;6047.15339852421;6051.818445446644;6058.485028772604;6059.424354686298;6059.515238780887;5795.565332600072;5829.8251052468495;5830.183774271605;5831.562632802556;5861.3845546217035;5939.851503712442;5978.491828194652;5982.581219314693;5998.880022399615;6000.069989151689;5964.970175149097;5968.552358573124;5970.522358211333;5980.9401905980385;5983.700814959235;5783.826485205451;5911.674857882857;5964.612300200473;5969.731362088716;5973.761049557969;4385.51759306476;4399.472063352418;4404.713693609905;4416.779161041935;4429.75636339998;3981.482407287034;3987.7407968481957;3996.480457540501;4009.498812648419;4016.5581786003518;5458.563314934875;5656.773729050792;5694.971525142348;5730.713464326767;5755;5880.441358070976;5961.552883533753;5986;5993.910091348634;6044.607100538451;5688.11834165705;5696.943030569641;5699.287589051369;5700.828975130753;5710.857228569319;5035.345405097314;5167.586593072545;5202.297689811827;5220.556252718486;5238.476152384731;6177.413145751147;6179.62922224659;6194.442500175006;6204.565680402328;6216.285127210429;5679.716014199191;6020.367861374581;6027.638341699512;6032.54755893301;6035;6130.3369889931655;6189.876202475835;6191.628502289877;6228.190335256388;6237.469815065589;5899.764009439575;5905.114232865105;5922.111683247547;5938.346781854079;5956.13636022783;5843.094320380348;6037.27552693662;6045.183900173421;6049.3950604939155;6054.031354983182;5899.439553242435;5912.379200183918;5918.2898052234;5919.526437885045;5964.433378829004;5828.6211396259105;5866.178734977021;5878.088896221093;5878.853028674317;5878.970605146947;5477.397486276427;5664.26364572603;5703.287089113861;5780.826575202751;5815.156802263564;5857.4435428634215;5872.265966754156;5884.705764711833;5893.410658934073;5898.233229680114;5724;5733;5758.884822303614;5770.596058276048;5774.133879918046 03:52:07 INFO - PROCESS | 30806 | |1;ext.html;621.91604133442;663.8805015097283;674.3357792574313;682.3415404135009;691.4122995453865;33144.66855331446;39753.60246397539;40375.79812100943;40742.388864167064;40792.38811417828;42972;43165;43388;43486.565134348646;43605;8762.693305734316;8936.955315223448;8939.731808045737;8948.149925757043;8959.28325733943;8760.211580957744;8783.824323513525;8892.510911899875;8897.555122243893;8905.376623636348;9146;9187.494687792168;9189.540522973857;9246.583903724348;9251.074892510762;9110.86333704995;9145.856767904012;9147.54262286883;9184.678536251198;9198.816023679556;9028.052054534244;9133.680321188793;9137.40606860552;9149.130832570896;9173.954130229373;43534.34698479525;43938;44045.33931991023;44088.77955610234;44116;3771.886843394675;4074.8370065197355;4097.692673049533;4286.752481358708;4675.719456832601;33404;34113.488297675554;34382.14044648879;34501.13747156316;35577;4189.413482112506;4230.344296634026;4232.492100947906;4238.788060596958;4255.510616279136;318407;319768;320377;320417;320995;64227;64403.35596643973;64479.67760161263;64508;64891;70980;73141;73290;73298.26701733022;73632.63183684154;17336.913315433594;17658.5585360367;17687.292508299524;17702.822971770376;17715.468535943943;13514.59456216315;13704.3833027514;13709.862901370858;13724.176549407068;13753.79369309461;21246.46883827917;21504;21568.137274509158;21706.782932170478;21706.78293217079;8007.279344858991;8039.155888631726;8133.715319963773;8189.385796065199;8304.501729896225;1043.9269251152498;1185.934773587461;1190.7023244188954;1193.278066769592;1206.4363228140203;34411.655883441344;36210.81894590563;37892.62107378946;38034.80982595125;38268.80865595654;1204.4459548607738;1239.4918083585867;1244.7510497900457;1296.5915736543147;1304.7455746129413;16561.42035028768;16802.83197168037;16922.069286189377;17031.744523831905;17032.403865864882;529780;539510;891304;898813;905434;63342.36657633457;64328;64394;64410.35589644044;64531.35468645347;1483.5475180069966;1530.869876060525;1558.3221298735086;1559.1892216047593;1567.3573834727706;32895.342093158484;33579.3284134311;33585.83207083949;34041.148971275914;34294.828525857214;54608.45391546193;55136.172957406474;55183.44816551783;55218.72390638021;55437.16844247259;427232;429291;429434;430007;430936;30025.849870750506;46119.538804612865;47041.764791175825;47355.526444735115;47645.28532072091;45267;46024;46553;46648.53351466442;47005.529944701484;38788.41817372798;39277.41083883801;39482.81551553458;40027.1994560113;40044;37246;38272.23455530818;38867;39292.21415571615;40388.19223615452;42359.3646095315;43702.56297437112;43936.34095488506;44789.32816007828;45209.09581808411;33481.497777532866;35203.64796352106;36473.27053458863;37271.6272837279;37967.240655186186;28684;29009.12972610825;29034.709652904046;29179.562306565844;29273.268168295963 03:52:07 INFO - PROCESS | 30806 | |2;jquery.html;441.65075693755574;444.8665400379885;446.8637065694962;447.63647938882696;455.94072770539844;18158.364457243984;18783;18909.905450472746;20499.795002049974;20543;18854.057297135158;19116.808831911676;19447.902760486177;19549.90225048873;19609.215631374762;5859.384764599719;5903;5972.850678733023;6018.488428483584;6022.277326720778;5913;5972.850678733023;5995.730192141364;6004.549658775588;6005.6396616203165;5697.6011679182475;5938;5953.642781433106;5999.640021598696;6017.699115044252;5941.554383421239;5944.2866855977345;5951.732172052268;5962.70186490678;5985.76056957719;5400.730828255357;5522.199281104257;5775.509081728058;5785.103308987113;5797.4782269595935;22559.533630313977;22589.548209035725;22781.886090569442;22990.425239368982;23430.7656923432;2361;2466.6176742604925;2548.069954466625;2552.199553713748;2707.7563019328354;10634.255602107856;10737.677869663923;10822.567097316176;10932.726681832939;15020.474283400028;2024.3218521795216;2093.340597711716;2109.177420805887;2143.4105620954206;2165.220520612578;69073.30926690719;70417.29582704158;71588;72810.27189728088;78554.60722696407;10930.508127134139;11133.332000080021;11355.772884542263;11635;11781.823272650918;15902.204889755465;16231.51305460838;16273.267702953395;16273.349066037463;16314.347426102822;8535.530545819915;8615.22462978335;8617.741467755977;8626.698065567674;8700.955885293804;8348.415610907177;8398.286145677686;8419.158084191655;8459.534725590152;8588.699395521127;4700.741459219776;4815.3258543803895;4829.9275510867365;4893.584045356185;4962;2115.259659119327;2118.8304935605115;2146.518901957644;2150.6558950567833;2169.3708824440737;1005.8792944846665;1031.6595523477235;1069.2141276162015;1116.5701205036119;1160.6924165096257;18582.44252672422;18686.626267474574;18938.52653683669;19018.144183511777;19299.324523641884;1069.1019543583427;1083.4257843343041;1090.7055095124272;1112.57165991094;1169.2049406403728;10859.131269498579;10949.945250273857;10994.28537145083;11011.119110471143;11017.83473247902;369205;375725;377238;471281;479051;98276.50861745789;102248.48875755722;102327;103999.48000260102;105790;1120.4565785594143;1141.2068612314363;1159.6694941941507;1163.1044096046166;1164.6622479481025;17194.914025429793;17237.22432490566;17419.738703919196;17495;17558.73661895098;24909.252722418358;25655;38450.61549384471;38874.22251555009;39894.80052599718;57981.13028304663;59413;59744.10383844333;59980.10029849643;60099;8876.86684699743;8964.372493925363;9001.279897608307;9055.592498337459;9154.58804353819;12866.935665321613;13302;13545.1195672281;13673.794893076412;13719.451221951409;8964.520854059007;11868.703282418008;11915.344656044;12021.579244726392;12216;11738.354390508604;11821.932638532187;11887;12134.575289864812;12249.755004899675;11899.702507437383;12102.75794484123;12195.268283902995;12394.504219831106;12487.750244995232;8628.870566941376;8796;8884.289256859565;8969.37214394986;9062.637494500146;9134.680286190218;10901.291416057931;11226.60706875288;11513.251638643462;11732.530698771954 03:52:07 INFO - PROCESS | 30806 | |3;mootools.html;1610.903345799252;1627.9348826046955;1817.3911739567245;1889.4803928919555;1897.0230331379341;7590.924090759091;8305;8579.74260772177;8754.343424243176;8755.124487551242;8493.660253589864;8537.95731021344;8561.828763424728;8613.569321533929;8622.611982460789;2381.559411508868;2381.7261014983283;2395.0300128448007;2412.8914198861094;2418.3349578865777;2395.9880200598973;2397.9640305395433;2440.3411079008656;2444.2300675287315;2445.7187423446267;2414.843035202715;2423.612222044473;2424.260600516842;2466.4450498637843;2467.679201703776;2449.497852940143;2461.1016978802786;2462.965554467128;2464.4578192797644;2494.1769216158623;2438.110089817204;2443.474652949624;2455.042533411971;2475.4677744284886;2485.155047283932;8824;8892.73321800347;8906.55467226636;8953.641854325819;8961.327900407496;5343.171808369709;5431.809886653988;5444.6188766786345;5452.073147564884;5458.863528411782;3473.89578312651;3481.669241422061;3515.1739341254784;3535.063208249816;3569.0720412692626;1196.9461374238092;1197.2995797458498;1200.951961921531;1225.577175874322;1230.4524486603466;12450.003999680095;12470.75058498834;12496.437660305217;12526;12535.561255356019;4627.1439783640135;4673.462551806586;4685.953140468551;4692.061587682477;4883.487233840396;10677.893221067845;10748.247622666495;10781.946090269656;10792.082672972729;10814.459277036274;5506.779728810803;5510.669359838423;5515;5536.806211782568;5561.694106824082;4354.716943398669;4810.975945120252;4899.779509922062;4958.107540642719;5045.268436076748;4271.8718438446895;4313.590208930146;4419.270820314612;4469.620082293041;4478.305862591304;1362.0805955979872;1365.0853927868352;1369.4111532041318;1374.4983081175299;1382.8962827787957;967.3663750243602;1022.5602990713916;1055.6938487838595;1058.9939557420482;1064.489045258265;5776.335721392094;5829.067349224189;5932.881342373128;5947.732352044169;6149;1018.6638409324905;1024.4928760263567;1046.1578429364436;1063.361982810323;1094.8357746338113;4002.3796311571755;4045.211183819127;4063.674906007512;4064.8577299794365;4090.611391917763;10377.377357358582;10787.946060269649;10795.028447439769;10805.513751881026;10827.621033263798;10825.350478971286;10924.836127458095;10942.398168100672;10961.83557246642;11004.614838480775;8363.790905227539;8375.371847111492;8383.28742056932;8487.321014318839;8501.447405918596;5637.154426836008;5740.540756739368;5752.568557358299;5756.884862302647;5881.5588830838715;9511.952440237754;9637.614495420385;9660.37207581505;9685.370450920667;9808.16630586408;9568.234541236545;9649.614015439303;9850.704478865646;9851.310408271638;10278.588856445958;6600.966995164993;7122.394596459359;7315.743948961761;7581.54510729358;7712;8463.915360846559;8480.61837217339;8491.660333586588;8503.277221436247;8529.104444033535;7334.853302934018;7499.925000749922;7594.202608726005;7738.458307918391;7793.727219547289;7485.962570187332;7570.242975702606;7619.580923049286;7654.770356889302;7660.846783064419;7289.125304963438;7327.303906128909;7333.816654583678;7344.8898266524975;7354.742584009534;4707.78814953321;5003.77483013258;5069.062223488666;5262.553830646088;5316.415194328698;5123.948760512496;5194.506521880416;5255;5300.416954135119;5328.866778330573 03:52:07 INFO - PROCESS | 30806 | |4;prototype.html;349.89153362457637;353.5351013417357;358.3174053428217;359.7068389262752;360.11950780342073;6610.570312929656;6631.701573429189;6642.402183803457;6654.567453115544;6799.048133261347;6647.468202543797;6662.367075127855;6673.09913161723;6682.231543372513;6700.664966751655;4850.514948505148;4912.606991440694;5014.072396606622;5025.497450254964;5073.289739436464;5033.471485494026;5059.139946209135;5064.594832413398;5067.797288108472;5072.0870243356185;4968.925466118011;5030.1448753711775;5032.572231360339;5039.7732102055315;5045.369328833895;5042.974785126087;5044.747762611854;5047.268146118829;5047.924281135767;5064.594832413398;4417.9116417671785;4426.026274219666;4428.202923473774;4431.047324825146;4434.091011342699;6242.6878656067465;6443.903341449882;6449.193850768654;6461.386168314003;6463.385978332051;5820.970895145497;5846.707664616794;5848.853778655525;5852.326982397036;5863.325717542494;7072.787816365517;7093.609851458168;7098.503104782667;7107.609081500567;7110.893336599956;4788.521147885183;4792.424909010941;4800.183968725325;4807.759612019385;4811.75941202942;7261.273872612802;7341.972123902605;7419.925800741978;7420.3321701046625;7428.851422971565;4944.3572335596145;4946.060248552763;4948;4956.529129732669;4958.181899986462;4977.502249775066;4988.850334489971;4997.075541024849;5001.8499445016705;5004.324416203839;5835.416458354131;5843.9773039717875;5849.181114643953;5849.590528663038;5852.326982396994;7058.505904586732;7084.079069720903;7111.715531378687;7119.359257666835;7123.002779610859;1734.620886981406;1755.8323714729818;1766.2316892151955;1766.8144844791111;1769.0977601423367;1137.2323681514945;1157.3171828621155;1160.3733983648735;1161.280006396023;1163.1508998431023;6658;6702.832429189211;6708.429783468362;6730.528862979544;6732.764353247613;7059.611721355374;7150.892736608955;7336.303051210127;7350.5957172354965;7366.594837283894;6695.397414232742;6750.831229219309;6764.289749576322;6765.627890466071;6767.796966091025;3952.3873799561115;3978.900527486778;4003.8798836034966;4004.8798536043964;4017.31705610047;7676.424268179909;7678.500897441649;7715.691372345043;7732.342750866239;7774.416918731118;7406.07424071991;7616.162222155558;7624.847503049908;7642.5032372895585;7643.044619422572;7731.420143489261;7739;7742.4580279381025;7749.380049596019;7761.767146985487;7392.408607311295;7421.962890185515;7433.256674332523;7438.44211684115;7446.70213191488;7219.133703955559;7239.420846332386;7240.710371585288;7256.96371518139;7257.673404696907;7441.925580744123;7660.693572257047;7681.9231807683445;7749.535027898344;7787.844243115219;4971.8011279549855;4991.700497970133;5002.099622068063;5025.597952163891;5027.4218464877;7316.853662926818;7333;7338.082739657543;7345.081864766904;7348.081489813773;7157.928420715934;7200.531965422231;7202.567845929261;7205.207427182901;7224.638768061681;7000.474964377794;7148.463865210234;7169.211386747558;7175.605341706257;7177.846646006282;6967.79096627102;6974.37230649244;6990.685419156049;7021.543599666005;7030;7174.964125179341;7208.96395518019;7210.89183662235;7216.314450127229;7216.4226861849875;6861.210960739579;6986.510944233854;7013.824654383681;7019.543729657556;7051.224365319913 03:52:07 INFO - PROCESS | 30806 | |5;yui.html;863.1153068105195;917.8485549884268;920.9907900920989;936.7330310861406;942.7831598732291;14415.78376324356;14700.852991470083;14816.333265003073;15872.365105395771;16055.357785688588;15601;15617;15669.373225071013;15763.054216747003;15811.051336919792;763.2977660552277;893.4192774696467;904.1546154345708;905.6649039855263;921.4885738415211;888.5157589113949;891.61660485991;891.8528442806929;898.6989358564889;899.883015208022;954.3271993244781;958.4297343080891;961.6345788600322;965.3001573858967;966.1063516247478;952.552300418802;953.9046095390474;954.5275088831038;954.5370495309769;955.9283053770995;697.769735987123;703.5848849179009;703.6341102626606;704.7498138160981;706.7137809187287;15438.07371557699;15494.61263468411;15508.14705191214;15527.611809704735;15551.922240388725;14125.505607303696;14134.151950882877;14156.85843141576;14192.148471091768;14224.14655120696;11011.751533297616;11152.665420037412;11175;11217.495212715447;11227.887721122848;3939.940900886489;3955.5253369595544;3984.5218573771044;4041.191761647682;4054.493188351456;54479;54983.72508137434;55131;55249;55696.44303556953;11369.829452558219;11546.76906461883;11601.12991525639;11689.123315751183;11755.764884702257;20256.493587660425;20374.898125509277;20382.388528344174;20441.38675839727;20453.181872724923;8326.417150799385;8525.872111918326;8531.189536993976;8535.957320213483;8550.529720865288;4878.463369029404;4915.508449155056;4976.2286845539;4995.350604421402;5052.014857102829;3597.1546686528645;3641.617630148849;3643.562772467321;3645.76302540334;3651.3245049665898;648.9967550162313;654.3848782144769;663.8572706868047;667.0694381338006;669.8660267946333;771.2711487644123;772.3319328780565;778.9961050194713;790.1624278265058;820.024171236227;8298.502089874506;9175.357724959189;9176.99053104158;9204.309676774268;9312.068793120769;658.1838520234875;680.9693563789542;712.1952194020827;755.5202446446436;777.9944372407859;4148.253314403376;4296.656267498655;4352.303631418958;4375.6280716138845;4382.255016647114;57006.71496642573;59936.10095848566;61875;61908;62574.68712656407;51545.48454515482;53085.46914530882;53930.73034634802;54309;54346;45859.54140458619;46339.30491042637;47679.04641907143;50641.49358506442;51110.23334649983;8432.494050356998;8533.232009119209;8584.785380365542;8598.914010860062;8735.737927862174;36543.81728091343;37131.25737485289;37279.81360093291;37423.62576374201;38060.42909356306;45749.08501830012;45812.31281530713;45881;46563;46662.066758665314;10601.204909631655;10661.25371224038;10673.252872299176;10721.249512534048;10741.194410419093;12819.935900320439;12978.80531792005;12996.48014079464;13083;13605;11838.467268972745;13049.34753262352;13174;13353.332333383487;13404.396802144121;12178.939105304771;12933;12990.415431305802;13049.673758156123;13485.460581576626;12688.6827829305;12898.613041608767;12900.870991289967;13134.737305254033;13169.341532923507;10752.354858708502;10857.457127143769;10871.67384978452;10965.56137754481;11214.607488737855;10448.582056717647;10671.306365086244;10697.625583104555;10719.24965252456;10789.136869050613 03:52:07 INFO - PROCESS | 30806 | __end_tp_report 03:52:07 INFO - PROCESS | 30806 | __start_cc_report 03:52:07 INFO - PROCESS | 30806 | _x_x_mozilla_cycle_collect,330 03:52:07 INFO - PROCESS | 30806 | __end_cc_report 03:52:07 INFO - PROCESS | 30806 | __startTimestamp1463827927316__endTimestamp 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | ------- Summary: start ------- 03:52:07 INFO - PROCESS | 30806 | Number of tests: 6 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | [#0] dojo.html Cycles:165 Average:5550.35 Median:5770.60 stddev:623.07 (10.8%) stddev-sans-first:600.11 03:52:07 INFO - PROCESS | 30806 | Values: 3328.6 3350.5 3406.9 3411.4 3424.8 5546.7 5555.2 5566.3 5587.8 5588.0 5551.7 5573.7 5576.2 5593.6 5614.5 5023.4 5032.7 5109.7 5110.9 5134.8 4977.6 5112.9 5203.5 5214.2 5218.1 5033.4 5069.6 5100.5 5158.0 5189.4 5098.7 5102.1 5159.1 5160.4 5161.4 5011.4 5089.7 5126.0 5135.7 5161.6 5341.4 5482.6 5511.9 5528.2 5529.4 5896.2 5931.8 5937.2 5939.7 5945.0 5796.6 5998.9 6000.7 6025.7 6028.5 5538.9 5557.8 5568.6 5652.8 5730.3 6047.2 6051.8 6058.5 6059.4 6059.5 5795.6 5829.8 5830.2 5831.6 5861.4 5939.9 5978.5 5982.6 5998.9 6000.1 5965.0 5968.6 5970.5 5980.9 5983.7 5783.8 5911.7 5964.6 5969.7 5973.8 4385.5 4399.5 4404.7 4416.8 4429.8 3981.5 3987.7 3996.5 4009.5 4016.6 5458.6 5656.8 5695.0 5730.7 5755.0 5880.4 5961.6 5986.0 5993.9 6044.6 5688.1 5696.9 5699.3 5700.8 5710.9 5035.3 5167.6 5202.3 5220.6 5238.5 6177.4 6179.6 6194.4 6204.6 6216.3 5679.7 6020.4 6027.6 6032.5 6035.0 6130.3 6189.9 6191.6 6228.2 6237.5 5899.8 5905.1 5922.1 5938.3 5956.1 5843.1 6037.3 6045.2 6049.4 6054.0 5899.4 5912.4 5918.3 5919.5 5964.4 5828.6 5866.2 5878.1 5878.9 5879.0 5477.4 5664.3 5703.3 5780.8 5815.2 5857.4 5872.3 5884.7 5893.4 5898.2 5724.0 5733.0 5758.9 5770.6 5774.1 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | [#1] ext.html Cycles:180 Average:66772.84 Median:215759.38 stddev:146054.93 (67.7%) stddev-sans-first:146380.20 03:52:07 INFO - PROCESS | 30806 | Values: 621.9 663.9 674.3 682.3 691.4 33144.7 39753.6 40375.8 40742.4 40792.4 42972.0 43165.0 43388.0 43486.6 43605.0 8762.7 8937.0 8939.7 8948.1 8959.3 8760.2 8783.8 8892.5 8897.6 8905.4 9146.0 9187.5 9189.5 9246.6 9251.1 9110.9 9145.9 9147.5 9184.7 9198.8 9028.1 9133.7 9137.4 9149.1 9174.0 43534.3 43938.0 44045.3 44088.8 44116.0 3771.9 4074.8 4097.7 4286.8 4675.7 33404.0 34113.5 34382.1 34501.1 35577.0 4189.4 4230.3 4232.5 4238.8 4255.5 318407.0 319768.0 320377.0 320417.0 320995.0 64227.0 64403.4 64479.7 64508.0 64891.0 70980.0 73141.0 73290.0 73298.3 73632.6 17336.9 17658.6 17687.3 17702.8 17715.5 13514.6 13704.4 13709.9 13724.2 13753.8 21246.5 21504.0 21568.1 21706.8 21706.8 8007.3 8039.2 8133.7 8189.4 8304.5 1043.9 1185.9 1190.7 1193.3 1206.4 34411.7 36210.8 37892.6 38034.8 38268.8 1204.4 1239.5 1244.8 1296.6 1304.7 16561.4 16802.8 16922.1 17031.7 17032.4 529780.0 539510.0 891304.0 898813.0 905434.0 63342.4 64328.0 64394.0 64410.4 64531.4 1483.5 1530.9 1558.3 1559.2 1567.4 32895.3 33579.3 33585.8 34041.1 34294.8 54608.5 55136.2 55183.4 55218.7 55437.2 427232.0 429291.0 429434.0 430007.0 430936.0 30025.8 46119.5 47041.8 47355.5 47645.3 45267.0 46024.0 46553.0 46648.5 47005.5 38788.4 39277.4 39482.8 40027.2 40044.0 37246.0 38272.2 38867.0 39292.2 40388.2 42359.4 43702.6 43936.3 44789.3 45209.1 33481.5 35203.6 36473.3 37271.6 37967.2 28684.0 29009.1 29034.7 29179.6 29273.3 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | [#2] jquery.html Cycles:180 Average:26951.00 Median:2167.30 stddev:69404.17 (3202.3%) stddev-sans-first:69570.32 03:52:07 INFO - PROCESS | 30806 | Values: 441.7 444.9 446.9 447.6 455.9 18158.4 18783.0 18909.9 20499.8 20543.0 18854.1 19116.8 19447.9 19549.9 19609.2 5859.4 5903.0 5972.9 6018.5 6022.3 5913.0 5972.9 5995.7 6004.5 6005.6 5697.6 5938.0 5953.6 5999.6 6017.7 5941.6 5944.3 5951.7 5962.7 5985.8 5400.7 5522.2 5775.5 5785.1 5797.5 22559.5 22589.5 22781.9 22990.4 23430.8 2361.0 2466.6 2548.1 2552.2 2707.8 10634.3 10737.7 10822.6 10932.7 15020.5 2024.3 2093.3 2109.2 2143.4 2165.2 69073.3 70417.3 71588.0 72810.3 78554.6 10930.5 11133.3 11355.8 11635.0 11781.8 15902.2 16231.5 16273.3 16273.3 16314.3 8535.5 8615.2 8617.7 8626.7 8701.0 8348.4 8398.3 8419.2 8459.5 8588.7 4700.7 4815.3 4829.9 4893.6 4962.0 2115.3 2118.8 2146.5 2150.7 2169.4 1005.9 1031.7 1069.2 1116.6 1160.7 18582.4 18686.6 18938.5 19018.1 19299.3 1069.1 1083.4 1090.7 1112.6 1169.2 10859.1 10949.9 10994.3 11011.1 11017.8 369205.0 375725.0 377238.0 471281.0 479051.0 98276.5 102248.5 102327.0 103999.5 105790.0 1120.5 1141.2 1159.7 1163.1 1164.7 17194.9 17237.2 17419.7 17495.0 17558.7 24909.3 25655.0 38450.6 38874.2 39894.8 57981.1 59413.0 59744.1 59980.1 60099.0 8876.9 8964.4 9001.3 9055.6 9154.6 12866.9 13302.0 13545.1 13673.8 13719.5 8964.5 11868.7 11915.3 12021.6 12216.0 11738.4 11821.9 11887.0 12134.6 12249.8 11899.7 12102.8 12195.3 12394.5 12487.8 8628.9 8796.0 8884.3 8969.4 9062.6 9134.7 10901.3 11226.6 11513.3 11732.5 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | [#3] mootools.html Cycles:180 Average:5834.30 Median:4759.38 stddev:3228.71 (67.8%) stddev-sans-first:3222.17 03:52:07 INFO - PROCESS | 30806 | Values: 1610.9 1627.9 1817.4 1889.5 1897.0 7590.9 8305.0 8579.7 8754.3 8755.1 8493.7 8538.0 8561.8 8613.6 8622.6 2381.6 2381.7 2395.0 2412.9 2418.3 2396.0 2398.0 2440.3 2444.2 2445.7 2414.8 2423.6 2424.3 2466.4 2467.7 2449.5 2461.1 2463.0 2464.5 2494.2 2438.1 2443.5 2455.0 2475.5 2485.2 8824.0 8892.7 8906.6 8953.6 8961.3 5343.2 5431.8 5444.6 5452.1 5458.9 3473.9 3481.7 3515.2 3535.1 3569.1 1196.9 1197.3 1201.0 1225.6 1230.5 12450.0 12470.8 12496.4 12526.0 12535.6 4627.1 4673.5 4686.0 4692.1 4883.5 10677.9 10748.2 10781.9 10792.1 10814.5 5506.8 5510.7 5515.0 5536.8 5561.7 4354.7 4811.0 4899.8 4958.1 5045.3 4271.9 4313.6 4419.3 4469.6 4478.3 1362.1 1365.1 1369.4 1374.5 1382.9 967.4 1022.6 1055.7 1059.0 1064.5 5776.3 5829.1 5932.9 5947.7 6149.0 1018.7 1024.5 1046.2 1063.4 1094.8 4002.4 4045.2 4063.7 4064.9 4090.6 10377.4 10787.9 10795.0 10805.5 10827.6 10825.4 10924.8 10942.4 10961.8 11004.6 8363.8 8375.4 8383.3 8487.3 8501.4 5637.2 5740.5 5752.6 5756.9 5881.6 9512.0 9637.6 9660.4 9685.4 9808.2 9568.2 9649.6 9850.7 9851.3 10278.6 6601.0 7122.4 7315.7 7581.5 7712.0 8463.9 8480.6 8491.7 8503.3 8529.1 7334.9 7499.9 7594.2 7738.5 7793.7 7486.0 7570.2 7619.6 7654.8 7660.8 7289.1 7327.3 7333.8 7344.9 7354.7 4707.8 5003.8 5069.1 5262.6 5316.4 5123.9 5194.5 5255.0 5300.4 5328.9 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | [#4] prototype.html Cycles:180 Average:5930.77 Median:6701.75 stddev:1822.31 (27.2%) stddev-sans-first:1778.63 03:52:07 INFO - PROCESS | 30806 | Values: 349.9 353.5 358.3 359.7 360.1 6610.6 6631.7 6642.4 6654.6 6799.0 6647.5 6662.4 6673.1 6682.2 6700.7 4850.5 4912.6 5014.1 5025.5 5073.3 5033.5 5059.1 5064.6 5067.8 5072.1 4968.9 5030.1 5032.6 5039.8 5045.4 5043.0 5044.7 5047.3 5047.9 5064.6 4417.9 4426.0 4428.2 4431.0 4434.1 6242.7 6443.9 6449.2 6461.4 6463.4 5821.0 5846.7 5848.9 5852.3 5863.3 7072.8 7093.6 7098.5 7107.6 7110.9 4788.5 4792.4 4800.2 4807.8 4811.8 7261.3 7342.0 7419.9 7420.3 7428.9 4944.4 4946.1 4948.0 4956.5 4958.2 4977.5 4988.9 4997.1 5001.8 5004.3 5835.4 5844.0 5849.2 5849.6 5852.3 7058.5 7084.1 7111.7 7119.4 7123.0 1734.6 1755.8 1766.2 1766.8 1769.1 1137.2 1157.3 1160.4 1161.3 1163.2 6658.0 6702.8 6708.4 6730.5 6732.8 7059.6 7150.9 7336.3 7350.6 7366.6 6695.4 6750.8 6764.3 6765.6 6767.8 3952.4 3978.9 4003.9 4004.9 4017.3 7676.4 7678.5 7715.7 7732.3 7774.4 7406.1 7616.2 7624.8 7642.5 7643.0 7731.4 7739.0 7742.5 7749.4 7761.8 7392.4 7422.0 7433.3 7438.4 7446.7 7219.1 7239.4 7240.7 7257.0 7257.7 7441.9 7660.7 7681.9 7749.5 7787.8 4971.8 4991.7 5002.1 5025.6 5027.4 7316.9 7333.0 7338.1 7345.1 7348.1 7157.9 7200.5 7202.6 7205.2 7224.6 7000.5 7148.5 7169.2 7175.6 7177.8 6967.8 6974.4 6990.7 7021.5 7030.0 7175.0 7209.0 7210.9 7216.3 7216.4 6861.2 6986.5 7013.8 7019.5 7051.2 03:52:07 INFO - PROCESS | 30806 | 03:52:07 INFO - PROCESS | 30806 | [#5] yui.html Cycles:180 Average:14981.37 Median:45780.70 stddev:16944.23 (37.0%) stddev-sans-first:16958.59 03:52:07 INFO - PROCESS | 30806 | Values: 863.1 917.8 921.0 936.7 942.8 14415.8 14700.9 14816.3 15872.4 16055.4 15601.0 15617.0 15669.4 15763.1 15811.1 763.3 893.4 904.2 905.7 921.5 888.5 891.6 891.9 898.7 899.9 954.3 958.4 961.6 965.3 966.1 952.6 953.9 954.5 954.5 955.9 697.8 703.6 703.6 704.7 706.7 15438.1 15494.6 15508.1 15527.6 15551.9 14125.5 14134.2 14156.9 14192.1 14224.1 11011.8 11152.7 11175.0 11217.5 11227.9 3939.9 3955.5 3984.5 4041.2 4054.5 54479.0 54983.7 55131.0 55249.0 55696.4 11369.8 11546.8 11601.1 11689.1 11755.8 20256.5 20374.9 20382.4 20441.4 20453.2 8326.4 8525.9 8531.2 8536.0 8550.5 4878.5 4915.5 4976.2 4995.4 5052.0 3597.2 3641.6 3643.6 3645.8 3651.3 649.0 654.4 663.9 667.1 669.9 771.3 772.3 779.0 790.2 820.0 8298.5 9175.4 9177.0 9204.3 9312.1 658.2 681.0 712.2 755.5 778.0 4148.3 4296.7 4352.3 4375.6 4382.3 57006.7 59936.1 61875.0 61908.0 62574.7 51545.5 53085.5 53930.7 54309.0 54346.0 45859.5 46339.3 47679.0 50641.5 51110.2 8432.5 8533.2 8584.8 8598.9 8735.7 36543.8 37131.3 37279.8 37423.6 38060.4 45749.1 45812.3 45881.0 46563.0 46662.1 10601.2 10661.3 10673.3 10721.2 10741.2 12819.9 12978.8 12996.5 13083.0 13605.0 11838.5 13049.3 13174.0 13353.3 13404.4 12178.9 12933.0 12990.4 13049.7 13485.5 12688.7 12898.6 12900.9 13134.7 13169.3 10752.4 10857.5 10871.7 10965.6 11214.6 10448.6 10671.3 10697.6 10719.2 10789.1 03:52:07 INFO - PROCESS | 30806 | -------- Summary: end -------- 03:52:07 INFO - PROCESS | 30806 | 03:52:08 INFO - TEST-INFO | 30806: exit 0 03:52:08 INFO - TEST-OK | dromaeo_css | took 1109418ms 03:52:08 INFO - TEST-START | kraken 03:52:08 INFO - operating with platform_type : linux_ 03:52:08 INFO - Initialising browser for kraken test... 03:52:08 INFO - TEST-INFO | started process 31048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFUH9m/profile http://localhost:42720/getInfo.html) 03:52:11 INFO - PROCESS | 31048 | 03:52:11 INFO - PROCESS | 31048 | (process:31125): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:52:12 INFO - PROCESS | 31048 | __metrics Screen width/height:1600/1200 03:52:12 INFO - PROCESS | 31048 | colorDepth:24 03:52:12 INFO - PROCESS | 31048 | Browser inner width/height: 1024/697 03:52:12 INFO - PROCESS | 31048 | __metrics 03:52:13 ERROR - PROCESS | 31048 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 03:52:14 INFO - TEST-INFO | 31048: exit 0 03:52:14 INFO - Browser initialized. 03:52:14 INFO - Running cycle 1/1 for kraken test... 03:52:14 INFO - TEST-INFO | started process 31176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQFUH9m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:15 INFO - PROCESS | 31176 | 03:52:15 INFO - PROCESS | 31176 | (process:31242): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:52:25 INFO - PROCESS | 31176 | RSS: Main: 151793664 03:52:25 INFO - PROCESS | 31176 | 03:52:28 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:29 INFO - PROCESS | 31176 | RSS: Main: 156250112 03:52:29 INFO - PROCESS | 31176 | 03:52:31 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-dft) 03:52:32 INFO - PROCESS | 31176 | RSS: Main: 156790784 03:52:32 INFO - PROCESS | 31176 | 03:52:35 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-fft) 03:52:36 INFO - PROCESS | 31176 | RSS: Main: 156618752 03:52:36 INFO - PROCESS | 31176 | 03:52:38 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42720/tests/kraken/driver.html?testName=audio-oscillator) 03:52:38 INFO - PROCESS | 31176 | RSS: Main: 156520448 03:52:38 INFO - PROCESS | 31176 | 03:52:40 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:41 INFO - PROCESS | 31176 | RSS: Main: 156405760 03:52:41 INFO - PROCESS | 31176 | 03:52:44 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42720/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:45 INFO - PROCESS | 31176 | RSS: Main: 157126656 03:52:45 INFO - PROCESS | 31176 | 03:52:48 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42720/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:49 INFO - PROCESS | 31176 | RSS: Main: 156999680 03:52:49 INFO - PROCESS | 31176 | 03:52:51 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42720/tests/kraken/driver.html?testName=json-parse-financial) 03:52:52 INFO - PROCESS | 31176 | RSS: Main: 156573696 03:52:52 INFO - PROCESS | 31176 | 03:52:54 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:54 INFO - PROCESS | 31176 | RSS: Main: 156844032 03:52:54 INFO - PROCESS | 31176 | 03:52:56 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:57 INFO - PROCESS | 31176 | RSS: Main: 156962816 03:52:57 INFO - PROCESS | 31176 | 03:52:59 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:59 INFO - PROCESS | 31176 | RSS: Main: 156999680 03:52:59 INFO - PROCESS | 31176 | 03:53:02 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:02 INFO - PROCESS | 31176 | RSS: Main: 157188096 03:53:02 INFO - PROCESS | 31176 | 03:53:05 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:06 INFO - PROCESS | 31176 | RSS: Main: 157642752 03:53:06 INFO - PROCESS | 31176 | 03:53:07 INFO - PROCESS | 31176 | Cycle 1(1): loaded http://localhost:42720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42720/tests/kraken/driver.html?testName=ai-astar) 03:53:08 INFO - PROCESS | 31176 | RSS: Main: 159145984 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | __start_tp_report 03:53:08 INFO - PROCESS | 31176 | _x_x_mozilla_page_load 03:53:08 INFO - PROCESS | 31176 | _x_x_mozilla_page_load_details 03:53:08 INFO - PROCESS | 31176 | |i|pagename|runs| 03:53:08 INFO - PROCESS | 31176 | |0;ai-astar;107;109;104;109;112;111;100;110;110;111 03:53:08 INFO - PROCESS | 31176 | |1;audio-beat-detection;155;133;158;185;130;152;151;133;182;128 03:53:08 INFO - PROCESS | 31176 | |2;audio-dft;163;163;163;162;162;163;163;163;162;160 03:53:08 INFO - PROCESS | 31176 | |3;audio-fft;76;76;76;168;77;75;76;75;156;77 03:53:08 INFO - PROCESS | 31176 | |4;audio-oscillator;92;93;153;93;92;93;142;92;93;154 03:53:08 INFO - PROCESS | 31176 | |5;imaging-gaussian-blur;117;117;118;117;118;118;117;117;117;117 03:53:08 INFO - PROCESS | 31176 | |6;imaging-darkroom;146;148;146;146;147;146;146;147;146;146 03:53:08 INFO - PROCESS | 31176 | |7;imaging-desaturate;94;96;95;96;95;96;96;95;95;95 03:53:08 INFO - PROCESS | 31176 | |8;json-parse-financial;57;57;55;57;56;54;53;71;53;57 03:53:08 INFO - PROCESS | 31176 | |9;json-stringify-tinderbox;58;58;58;57;58;58;57;58;58;57 03:53:08 INFO - PROCESS | 31176 | |10;stanford-crypto-aes;73;73;75;73;78;75;76;75;75;76 03:53:08 INFO - PROCESS | 31176 | |11;stanford-crypto-ccm;119;118;122;116;122;122;121;117;128;133 03:53:08 INFO - PROCESS | 31176 | |12;stanford-crypto-pbkdf2;165;167;165;162;166;158;166;163;167;160 03:53:08 INFO - PROCESS | 31176 | |13;stanford-crypto-sha256-iterative;66;69;71;67;70;66;69;64;68;66 03:53:08 INFO - PROCESS | 31176 | __end_tp_report 03:53:08 INFO - PROCESS | 31176 | __start_cc_report 03:53:08 INFO - PROCESS | 31176 | _x_x_mozilla_cycle_collect,840 03:53:08 INFO - PROCESS | 31176 | __end_cc_report 03:53:08 INFO - PROCESS | 31176 | __startTimestamp1463827988134__endTimestamp 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | ------- Summary: start ------- 03:53:08 INFO - PROCESS | 31176 | Number of tests: 14 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#0] ai-astar Cycles:10 Average:108.30 Median:110.00 stddev:3.71 (3.4%) stddev-sans-first:3.91 03:53:08 INFO - PROCESS | 31176 | Values: 107.0 109.0 104.0 109.0 112.0 111.0 100.0 110.0 110.0 111.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:153.50 stddev:20.55 (13.4%) stddev-sans-first:21.74 03:53:08 INFO - PROCESS | 31176 | Values: 155.0 133.0 158.0 185.0 130.0 152.0 151.0 133.0 182.0 128.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 03:53:08 INFO - PROCESS | 31176 | Values: 163.0 163.0 163.0 162.0 162.0 163.0 163.0 163.0 162.0 160.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:36.38 (47.9%) stddev-sans-first:38.05 03:53:08 INFO - PROCESS | 31176 | Values: 76.0 76.0 76.0 168.0 77.0 75.0 76.0 75.0 156.0 77.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.50 stddev:27.76 (30.0%) stddev-sans-first:28.70 03:53:08 INFO - PROCESS | 31176 | Values: 92.0 93.0 153.0 93.0 92.0 93.0 142.0 92.0 93.0 154.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:53:08 INFO - PROCESS | 31176 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:53:08 INFO - PROCESS | 31176 | Values: 146.0 148.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 03:53:08 INFO - PROCESS | 31176 | Values: 94.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:5.19 (9.1%) stddev-sans-first:5.50 03:53:08 INFO - PROCESS | 31176 | Values: 57.0 57.0 55.0 57.0 56.0 54.0 53.0 71.0 53.0 57.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:53:08 INFO - PROCESS | 31176 | Values: 58.0 58.0 58.0 57.0 58.0 58.0 57.0 58.0 58.0 57.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:1.60 (2.1%) stddev-sans-first:1.54 03:53:08 INFO - PROCESS | 31176 | Values: 73.0 73.0 75.0 73.0 78.0 75.0 76.0 75.0 75.0 76.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:5.20 (4.3%) stddev-sans-first:5.42 03:53:08 INFO - PROCESS | 31176 | Values: 119.0 118.0 122.0 116.0 122.0 122.0 121.0 117.0 128.0 133.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:165.50 stddev:3.07 (1.9%) stddev-sans-first:3.23 03:53:08 INFO - PROCESS | 31176 | Values: 165.0 167.0 165.0 162.0 166.0 158.0 166.0 163.0 167.0 160.0 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - PROCESS | 31176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.50 stddev:2.17 (3.2%) stddev-sans-first:2.22 03:53:08 INFO - PROCESS | 31176 | Values: 66.0 69.0 71.0 67.0 70.0 66.0 69.0 64.0 68.0 66.0 03:53:08 INFO - PROCESS | 31176 | -------- Summary: end -------- 03:53:08 INFO - PROCESS | 31176 | 03:53:08 INFO - TEST-INFO | 31176: exit 0 03:53:09 INFO - TEST-OK | kraken | took 60994ms 03:53:09 INFO - SUITE-END | took 1170s 03:53:09 INFO - Completed test suite (00:19:30) 03:53:09 INFO - javascript benchmark 03:53:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.5672862527877, 3350.514175444561, 3406.8807591734294, 3411.3688967541007, 3424.8458819353127, 5546.722663866811, 5555.166724991253, 5566.304211973504, 5587.83236502905, 5587.9662262481415, 5551.72241387931, 5573.693446860421, 5576.191452239423, 5593.580481463896, 5614.522765564921, 5023.37207849018, 5032.698038117706, 5109.744512774365, 5110.897782044357, 5134.820281290155, 4977.576905962997, 5112.8977420451565, 5203.4536373680785, 5214.165733482643, 5218.086834803913, 5033.421156567005, 5069.619778516608, 5100.489951004907, 5158.0, 5189.351331083614, 5098.745062746848, 5102.081625307444, 5159.097157997336, 5160.432352441228, 5161.406438259611, 5011.373578302712, 5089.6691715038405, 5125.974370128163, 5135.743212839343, 5161.561267292284, 5341.359036915556, 5482.616216864821, 5511.862203444906, 5528.198411230349, 5529.447055294479, 5896.233489646362, 5931.762729490858, 5937.198478205431, 5939.703014849283, 5945.048792193272, 5796.594238403313, 5998.8500287492725, 6000.729967151488, 6025.668588227646, 6028.517718582503, 5538.889222215574, 5557.833265002016, 5568.554515638739, 5652.773889044433, 5730.255066841326, 6047.15339852421, 6051.818445446644, 6058.485028772604, 6059.424354686298, 6059.515238780887, 5795.565332600072, 5829.8251052468495, 5830.183774271605, 5831.562632802556, 5861.3845546217035, 5939.851503712442, 5978.491828194652, 5982.581219314693, 5998.880022399615, 6000.069989151689, 5964.970175149097, 5968.552358573124, 5970.522358211333, 5980.9401905980385, 5983.700814959235, 5783.826485205451, 5911.674857882857, 5964.612300200473, 5969.731362088716, 5973.761049557969, 4385.51759306476, 4399.472063352418, 4404.713693609905, 4416.779161041935, 4429.75636339998, 3981.482407287034, 3987.7407968481957, 3996.480457540501, 4009.498812648419, 4016.5581786003518, 5458.563314934875, 5656.773729050792, 5694.971525142348, 5730.713464326767, 5755.0, 5880.441358070976, 5961.552883533753, 5986.0, 5993.910091348634, 6044.607100538451, 5688.11834165705, 5696.943030569641, 5699.287589051369, 5700.828975130753, 5710.857228569319, 5035.345405097314, 5167.586593072545, 5202.297689811827, 5220.556252718486, 5238.476152384731, 6177.413145751147, 6179.62922224659, 6194.442500175006, 6204.565680402328, 6216.285127210429, 5679.716014199191, 6020.367861374581, 6027.638341699512, 6032.54755893301, 6035.0, 6130.3369889931655, 6189.876202475835, 6191.628502289877, 6228.190335256388, 6237.469815065589, 5899.764009439575, 5905.114232865105, 5922.111683247547, 5938.346781854079, 5956.13636022783, 5843.094320380348, 6037.27552693662, 6045.183900173421, 6049.3950604939155, 6054.031354983182, 5899.439553242435, 5912.379200183918, 5918.2898052234, 5919.526437885045, 5964.433378829004, 5828.6211396259105, 5866.178734977021, 5878.088896221093, 5878.853028674317, 5878.970605146947, 5477.397486276427, 5664.26364572603, 5703.287089113861, 5780.826575202751, 5815.156802263564, 5857.4435428634215, 5872.265966754156, 5884.705764711833, 5893.410658934073, 5898.233229680114, 5724.0, 5733.0, 5758.884822303614, 5770.596058276048, 5774.133879918046], "value": 5509.431091288757, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.91604133442, 663.8805015097283, 674.3357792574313, 682.3415404135009, 691.4122995453865, 33144.66855331446, 39753.60246397539, 40375.79812100943, 40742.388864167064, 40792.38811417828, 42972.0, 43165.0, 43388.0, 43486.565134348646, 43605.0, 8762.693305734316, 8936.955315223448, 8939.731808045737, 8948.149925757043, 8959.28325733943, 8760.211580957744, 8783.824323513525, 8892.510911899875, 8897.555122243893, 8905.376623636348, 9146.0, 9187.494687792168, 9189.540522973857, 9246.583903724348, 9251.074892510762, 9110.86333704995, 9145.856767904012, 9147.54262286883, 9184.678536251198, 9198.816023679556, 9028.052054534244, 9133.680321188793, 9137.40606860552, 9149.130832570896, 9173.954130229373, 43534.34698479525, 43938.0, 44045.33931991023, 44088.77955610234, 44116.0, 3771.886843394675, 4074.8370065197355, 4097.692673049533, 4286.752481358708, 4675.719456832601, 33404.0, 34113.488297675554, 34382.14044648879, 34501.13747156316, 35577.0, 4189.413482112506, 4230.344296634026, 4232.492100947906, 4238.788060596958, 4255.510616279136, 318407.0, 319768.0, 320377.0, 320417.0, 320995.0, 64227.0, 64403.35596643973, 64479.67760161263, 64508.0, 64891.0, 70980.0, 73141.0, 73290.0, 73298.26701733022, 73632.63183684154, 17336.913315433594, 17658.5585360367, 17687.292508299524, 17702.822971770376, 17715.468535943943, 13514.59456216315, 13704.3833027514, 13709.862901370858, 13724.176549407068, 13753.79369309461, 21246.46883827917, 21504.0, 21568.137274509158, 21706.782932170478, 21706.78293217079, 8007.279344858991, 8039.155888631726, 8133.715319963773, 8189.385796065199, 8304.501729896225, 1043.9269251152498, 1185.934773587461, 1190.7023244188954, 1193.278066769592, 1206.4363228140203, 34411.655883441344, 36210.81894590563, 37892.62107378946, 38034.80982595125, 38268.80865595654, 1204.4459548607738, 1239.4918083585867, 1244.7510497900457, 1296.5915736543147, 1304.7455746129413, 16561.42035028768, 16802.83197168037, 16922.069286189377, 17031.744523831905, 17032.403865864882, 529780.0, 539510.0, 891304.0, 898813.0, 905434.0, 63342.36657633457, 64328.0, 64394.0, 64410.35589644044, 64531.35468645347, 1483.5475180069966, 1530.869876060525, 1558.3221298735086, 1559.1892216047593, 1567.3573834727706, 32895.342093158484, 33579.3284134311, 33585.83207083949, 34041.148971275914, 34294.828525857214, 54608.45391546193, 55136.172957406474, 55183.44816551783, 55218.72390638021, 55437.16844247259, 427232.0, 429291.0, 429434.0, 430007.0, 430936.0, 30025.849870750506, 46119.538804612865, 47041.764791175825, 47355.526444735115, 47645.28532072091, 45267.0, 46024.0, 46553.0, 46648.53351466442, 47005.529944701484, 38788.41817372798, 39277.41083883801, 39482.81551553458, 40027.1994560113, 40044.0, 37246.0, 38272.23455530818, 38867.0, 39292.21415571615, 40388.19223615452, 42359.3646095315, 43702.56297437112, 43936.34095488506, 44789.32816007828, 45209.09581808411, 33481.497777532866, 35203.64796352106, 36473.27053458863, 37271.6272837279, 37967.240655186186, 28684.0, 29009.12972610825, 29034.709652904046, 29179.562306565844, 29273.268168295963], "value": 21481.835490515674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.65075693755574, 444.8665400379885, 446.8637065694962, 447.63647938882696, 455.94072770539844, 18158.364457243984, 18783.0, 18909.905450472746, 20499.795002049974, 20543.0, 18854.057297135158, 19116.808831911676, 19447.902760486177, 19549.90225048873, 19609.215631374762, 5859.384764599719, 5903.0, 5972.850678733023, 6018.488428483584, 6022.277326720778, 5913.0, 5972.850678733023, 5995.730192141364, 6004.549658775588, 6005.6396616203165, 5697.6011679182475, 5938.0, 5953.642781433106, 5999.640021598696, 6017.699115044252, 5941.554383421239, 5944.2866855977345, 5951.732172052268, 5962.70186490678, 5985.76056957719, 5400.730828255357, 5522.199281104257, 5775.509081728058, 5785.103308987113, 5797.4782269595935, 22559.533630313977, 22589.548209035725, 22781.886090569442, 22990.425239368982, 23430.7656923432, 2361.0, 2466.6176742604925, 2548.069954466625, 2552.199553713748, 2707.7563019328354, 10634.255602107856, 10737.677869663923, 10822.567097316176, 10932.726681832939, 15020.474283400028, 2024.3218521795216, 2093.340597711716, 2109.177420805887, 2143.4105620954206, 2165.220520612578, 69073.30926690719, 70417.29582704158, 71588.0, 72810.27189728088, 78554.60722696407, 10930.508127134139, 11133.332000080021, 11355.772884542263, 11635.0, 11781.823272650918, 15902.204889755465, 16231.51305460838, 16273.267702953395, 16273.349066037463, 16314.347426102822, 8535.530545819915, 8615.22462978335, 8617.741467755977, 8626.698065567674, 8700.955885293804, 8348.415610907177, 8398.286145677686, 8419.158084191655, 8459.534725590152, 8588.699395521127, 4700.741459219776, 4815.3258543803895, 4829.9275510867365, 4893.584045356185, 4962.0, 2115.259659119327, 2118.8304935605115, 2146.518901957644, 2150.6558950567833, 2169.3708824440737, 1005.8792944846665, 1031.6595523477235, 1069.2141276162015, 1116.5701205036119, 1160.6924165096257, 18582.44252672422, 18686.626267474574, 18938.52653683669, 19018.144183511777, 19299.324523641884, 1069.1019543583427, 1083.4257843343041, 1090.7055095124272, 1112.57165991094, 1169.2049406403728, 10859.131269498579, 10949.945250273857, 10994.28537145083, 11011.119110471143, 11017.83473247902, 369205.0, 375725.0, 377238.0, 471281.0, 479051.0, 98276.50861745789, 102248.48875755722, 102327.0, 103999.48000260102, 105790.0, 1120.4565785594143, 1141.2068612314363, 1159.6694941941507, 1163.1044096046166, 1164.6622479481025, 17194.914025429793, 17237.22432490566, 17419.738703919196, 17495.0, 17558.73661895098, 24909.252722418358, 25655.0, 38450.61549384471, 38874.22251555009, 39894.80052599718, 57981.13028304663, 59413.0, 59744.10383844333, 59980.10029849643, 60099.0, 8876.86684699743, 8964.372493925363, 9001.279897608307, 9055.592498337459, 9154.58804353819, 12866.935665321613, 13302.0, 13545.1195672281, 13673.794893076412, 13719.451221951409, 8964.520854059007, 11868.703282418008, 11915.344656044, 12021.579244726392, 12216.0, 11738.354390508604, 11821.932638532187, 11887.0, 12134.575289864812, 12249.755004899675, 11899.702507437383, 12102.75794484123, 12195.268283902995, 12394.504219831106, 12487.750244995232, 8628.870566941376, 8796.0, 8884.289256859565, 8969.37214394986, 9062.637494500146, 9134.680286190218, 10901.291416057931, 11226.60706875288, 11513.251638643462, 11732.530698771954], "value": 9466.056887104267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1610.903345799252, 1627.9348826046955, 1817.3911739567245, 1889.4803928919555, 1897.0230331379341, 7590.924090759091, 8305.0, 8579.74260772177, 8754.343424243176, 8755.124487551242, 8493.660253589864, 8537.95731021344, 8561.828763424728, 8613.569321533929, 8622.611982460789, 2381.559411508868, 2381.7261014983283, 2395.0300128448007, 2412.8914198861094, 2418.3349578865777, 2395.9880200598973, 2397.9640305395433, 2440.3411079008656, 2444.2300675287315, 2445.7187423446267, 2414.843035202715, 2423.612222044473, 2424.260600516842, 2466.4450498637843, 2467.679201703776, 2449.497852940143, 2461.1016978802786, 2462.965554467128, 2464.4578192797644, 2494.1769216158623, 2438.110089817204, 2443.474652949624, 2455.042533411971, 2475.4677744284886, 2485.155047283932, 8824.0, 8892.73321800347, 8906.55467226636, 8953.641854325819, 8961.327900407496, 5343.171808369709, 5431.809886653988, 5444.6188766786345, 5452.073147564884, 5458.863528411782, 3473.89578312651, 3481.669241422061, 3515.1739341254784, 3535.063208249816, 3569.0720412692626, 1196.9461374238092, 1197.2995797458498, 1200.951961921531, 1225.577175874322, 1230.4524486603466, 12450.003999680095, 12470.75058498834, 12496.437660305217, 12526.0, 12535.561255356019, 4627.1439783640135, 4673.462551806586, 4685.953140468551, 4692.061587682477, 4883.487233840396, 10677.893221067845, 10748.247622666495, 10781.946090269656, 10792.082672972729, 10814.459277036274, 5506.779728810803, 5510.669359838423, 5515.0, 5536.806211782568, 5561.694106824082, 4354.716943398669, 4810.975945120252, 4899.779509922062, 4958.107540642719, 5045.268436076748, 4271.8718438446895, 4313.590208930146, 4419.270820314612, 4469.620082293041, 4478.305862591304, 1362.0805955979872, 1365.0853927868352, 1369.4111532041318, 1374.4983081175299, 1382.8962827787957, 967.3663750243602, 1022.5602990713916, 1055.6938487838595, 1058.9939557420482, 1064.489045258265, 5776.335721392094, 5829.067349224189, 5932.881342373128, 5947.732352044169, 6149.0, 1018.6638409324905, 1024.4928760263567, 1046.1578429364436, 1063.361982810323, 1094.8357746338113, 4002.3796311571755, 4045.211183819127, 4063.674906007512, 4064.8577299794365, 4090.611391917763, 10377.377357358582, 10787.946060269649, 10795.028447439769, 10805.513751881026, 10827.621033263798, 10825.350478971286, 10924.836127458095, 10942.398168100672, 10961.83557246642, 11004.614838480775, 8363.790905227539, 8375.371847111492, 8383.28742056932, 8487.321014318839, 8501.447405918596, 5637.154426836008, 5740.540756739368, 5752.568557358299, 5756.884862302647, 5881.5588830838715, 9511.952440237754, 9637.614495420385, 9660.37207581505, 9685.370450920667, 9808.16630586408, 9568.234541236545, 9649.614015439303, 9850.704478865646, 9851.310408271638, 10278.588856445958, 6600.966995164993, 7122.394596459359, 7315.743948961761, 7581.54510729358, 7712.0, 8463.915360846559, 8480.61837217339, 8491.660333586588, 8503.277221436247, 8529.104444033535, 7334.853302934018, 7499.925000749922, 7594.202608726005, 7738.458307918391, 7793.727219547289, 7485.962570187332, 7570.242975702606, 7619.580923049286, 7654.770356889302, 7660.846783064419, 7289.125304963438, 7327.303906128909, 7333.816654583678, 7344.8898266524975, 7354.742584009534, 4707.78814953321, 5003.77483013258, 5069.062223488666, 5262.553830646088, 5316.415194328698, 5123.948760512496, 5194.506521880416, 5255.0, 5300.416954135119, 5328.866778330573], "value": 4746.399889054803, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.89153362457637, 353.5351013417357, 358.3174053428217, 359.7068389262752, 360.11950780342073, 6610.570312929656, 6631.701573429189, 6642.402183803457, 6654.567453115544, 6799.048133261347, 6647.468202543797, 6662.367075127855, 6673.09913161723, 6682.231543372513, 6700.664966751655, 4850.514948505148, 4912.606991440694, 5014.072396606622, 5025.497450254964, 5073.289739436464, 5033.471485494026, 5059.139946209135, 5064.594832413398, 5067.797288108472, 5072.0870243356185, 4968.925466118011, 5030.1448753711775, 5032.572231360339, 5039.7732102055315, 5045.369328833895, 5042.974785126087, 5044.747762611854, 5047.268146118829, 5047.924281135767, 5064.594832413398, 4417.9116417671785, 4426.026274219666, 4428.202923473774, 4431.047324825146, 4434.091011342699, 6242.6878656067465, 6443.903341449882, 6449.193850768654, 6461.386168314003, 6463.385978332051, 5820.970895145497, 5846.707664616794, 5848.853778655525, 5852.326982397036, 5863.325717542494, 7072.787816365517, 7093.609851458168, 7098.503104782667, 7107.609081500567, 7110.893336599956, 4788.521147885183, 4792.424909010941, 4800.183968725325, 4807.759612019385, 4811.75941202942, 7261.273872612802, 7341.972123902605, 7419.925800741978, 7420.3321701046625, 7428.851422971565, 4944.3572335596145, 4946.060248552763, 4948.0, 4956.529129732669, 4958.181899986462, 4977.502249775066, 4988.850334489971, 4997.075541024849, 5001.8499445016705, 5004.324416203839, 5835.416458354131, 5843.9773039717875, 5849.181114643953, 5849.590528663038, 5852.326982396994, 7058.505904586732, 7084.079069720903, 7111.715531378687, 7119.359257666835, 7123.002779610859, 1734.620886981406, 1755.8323714729818, 1766.2316892151955, 1766.8144844791111, 1769.0977601423367, 1137.2323681514945, 1157.3171828621155, 1160.3733983648735, 1161.280006396023, 1163.1508998431023, 6658.0, 6702.832429189211, 6708.429783468362, 6730.528862979544, 6732.764353247613, 7059.611721355374, 7150.892736608955, 7336.303051210127, 7350.5957172354965, 7366.594837283894, 6695.397414232742, 6750.831229219309, 6764.289749576322, 6765.627890466071, 6767.796966091025, 3952.3873799561115, 3978.900527486778, 4003.8798836034966, 4004.8798536043964, 4017.31705610047, 7676.424268179909, 7678.500897441649, 7715.691372345043, 7732.342750866239, 7774.416918731118, 7406.07424071991, 7616.162222155558, 7624.847503049908, 7642.5032372895585, 7643.044619422572, 7731.420143489261, 7739.0, 7742.4580279381025, 7749.380049596019, 7761.767146985487, 7392.408607311295, 7421.962890185515, 7433.256674332523, 7438.44211684115, 7446.70213191488, 7219.133703955559, 7239.420846332386, 7240.710371585288, 7256.96371518139, 7257.673404696907, 7441.925580744123, 7660.693572257047, 7681.9231807683445, 7749.535027898344, 7787.844243115219, 4971.8011279549855, 4991.700497970133, 5002.099622068063, 5025.597952163891, 5027.4218464877, 7316.853662926818, 7333.0, 7338.082739657543, 7345.081864766904, 7348.081489813773, 7157.928420715934, 7200.531965422231, 7202.567845929261, 7205.207427182901, 7224.638768061681, 7000.474964377794, 7148.463865210234, 7169.211386747558, 7175.605341706257, 7177.846646006282, 6967.79096627102, 6974.37230649244, 6990.685419156049, 7021.543599666005, 7030.0, 7174.964125179341, 7208.96395518019, 7210.89183662235, 7216.314450127229, 7216.4226861849875, 6861.210960739579, 6986.510944233854, 7013.824654383681, 7019.543729657556, 7051.224365319913], "value": 5328.224321587227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.1153068105195, 917.8485549884268, 920.9907900920989, 936.7330310861406, 942.7831598732291, 14415.78376324356, 14700.852991470083, 14816.333265003073, 15872.365105395771, 16055.357785688588, 15601.0, 15617.0, 15669.373225071013, 15763.054216747003, 15811.051336919792, 763.2977660552277, 893.4192774696467, 904.1546154345708, 905.6649039855263, 921.4885738415211, 888.5157589113949, 891.61660485991, 891.8528442806929, 898.6989358564889, 899.883015208022, 954.3271993244781, 958.4297343080891, 961.6345788600322, 965.3001573858967, 966.1063516247478, 952.552300418802, 953.9046095390474, 954.5275088831038, 954.5370495309769, 955.9283053770995, 697.769735987123, 703.5848849179009, 703.6341102626606, 704.7498138160981, 706.7137809187287, 15438.07371557699, 15494.61263468411, 15508.14705191214, 15527.611809704735, 15551.922240388725, 14125.505607303696, 14134.151950882877, 14156.85843141576, 14192.148471091768, 14224.14655120696, 11011.751533297616, 11152.665420037412, 11175.0, 11217.495212715447, 11227.887721122848, 3939.940900886489, 3955.5253369595544, 3984.5218573771044, 4041.191761647682, 4054.493188351456, 54479.0, 54983.72508137434, 55131.0, 55249.0, 55696.44303556953, 11369.829452558219, 11546.76906461883, 11601.12991525639, 11689.123315751183, 11755.764884702257, 20256.493587660425, 20374.898125509277, 20382.388528344174, 20441.38675839727, 20453.181872724923, 8326.417150799385, 8525.872111918326, 8531.189536993976, 8535.957320213483, 8550.529720865288, 4878.463369029404, 4915.508449155056, 4976.2286845539, 4995.350604421402, 5052.014857102829, 3597.1546686528645, 3641.617630148849, 3643.562772467321, 3645.76302540334, 3651.3245049665898, 648.9967550162313, 654.3848782144769, 663.8572706868047, 667.0694381338006, 669.8660267946333, 771.2711487644123, 772.3319328780565, 778.9961050194713, 790.1624278265058, 820.024171236227, 8298.502089874506, 9175.357724959189, 9176.99053104158, 9204.309676774268, 9312.068793120769, 658.1838520234875, 680.9693563789542, 712.1952194020827, 755.5202446446436, 777.9944372407859, 4148.253314403376, 4296.656267498655, 4352.303631418958, 4375.6280716138845, 4382.255016647114, 57006.71496642573, 59936.10095848566, 61875.0, 61908.0, 62574.68712656407, 51545.48454515482, 53085.46914530882, 53930.73034634802, 54309.0, 54346.0, 45859.54140458619, 46339.30491042637, 47679.04641907143, 50641.49358506442, 51110.23334649983, 8432.494050356998, 8533.232009119209, 8584.785380365542, 8598.914010860062, 8735.737927862174, 36543.81728091343, 37131.25737485289, 37279.81360093291, 37423.62576374201, 38060.42909356306, 45749.08501830012, 45812.31281530713, 45881.0, 46563.0, 46662.066758665314, 10601.204909631655, 10661.25371224038, 10673.252872299176, 10721.249512534048, 10741.194410419093, 12819.935900320439, 12978.80531792005, 12996.48014079464, 13083.0, 13605.0, 11838.467268972745, 13049.34753262352, 13174.0, 13353.332333383487, 13404.396802144121, 12178.939105304771, 12933.0, 12990.415431305802, 13049.673758156123, 13485.460581576626, 12688.6827829305, 12898.613041608767, 12900.870991289967, 13134.737305254033, 13169.341532923507, 10752.354858708502, 10857.457127143769, 10871.67384978452, 10965.56137754481, 11214.607488737855, 10448.582056717647, 10671.306365086244, 10697.625583104555, 10719.24965252456, 10789.136869050613], "value": 6995.0636979316405, "unit": "score"}], "name": "dromaeo_css", "value": 7635.791896009392, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 104.0, 109.0, 112.0, 111.0, 100.0, 110.0, 110.0, 111.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 133.0, 158.0, 185.0, 130.0, 152.0, 151.0, 133.0, 182.0, 128.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 162.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 168.0, 77.0, 75.0, 76.0, 75.0, 156.0, 77.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 153.0, 93.0, 92.0, 93.0, 142.0, 92.0, 93.0, 154.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 57.0, 56.0, 54.0, 53.0, 71.0, 53.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 57.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 73.0, 78.0, 75.0, 76.0, 75.0, 75.0, 76.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 122.0, 116.0, 122.0, 122.0, 121.0, 117.0, 128.0, 133.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 162.0, 166.0, 158.0, 166.0, 163.0, 167.0, 160.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 71.0, 67.0, 70.0, 66.0, 69.0, 64.0, 68.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1526.2, "alertThreshold": 2.0}]} 03:53:09 INFO - Return code: 0 03:53:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:53:09 ERROR - # TBPL SUCCESS # 03:53:09 INFO - Running post-action listener: _resource_record_post_action 03:53:09 INFO - Running post-run listener: _resource_record_post_run 03:53:10 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 498073600; Read time: 0; Write time: 362776 03:53:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248688640; Read time: 0; Write time: 238732 03:53:10 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 249384960; Read time: 0; Write time: 124044 03:53:10 INFO - Running post-run listener: _upload_blobber_files 03:53:10 INFO - Blob upload gear active. 03:53:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:10 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 03:53:10 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:10 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:11 INFO - (blobuploader) - INFO - Done attempting. 03:53:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:13 INFO - (blobuploader) - INFO - Done attempting. 03:53:13 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:13 INFO - Return code: 0 03:53:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba93510d06f71eec904f037521a7a5660f08aade329d88f2c72e68e8548e3795e6479876f3672b0141f510e767c3ea63740c4bdbd456bdc3d0bf3fe03bf1112", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db04f4da3c8695849eae8eeadcaddf4e64c04e3ac70233b8074e01054cf2929b9fd58c0551fb7ded2c7bbe7e686ff1448e5e09ccf6f977d1843f123451c4b79"} 03:53:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:13 INFO - Contents: 03:53:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba93510d06f71eec904f037521a7a5660f08aade329d88f2c72e68e8548e3795e6479876f3672b0141f510e767c3ea63740c4bdbd456bdc3d0bf3fe03bf1112", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db04f4da3c8695849eae8eeadcaddf4e64c04e3ac70233b8074e01054cf2929b9fd58c0551fb7ded2c7bbe7e686ff1448e5e09ccf6f977d1843f123451c4b79"} 03:53:13 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:13 INFO - Copying logs to upload dir... 03:53:13 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.700816 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-21 03:53:12.328432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 03:53:12.332033) ========= 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=d2a8c569965ab8367867b893000001a1-1463823591.129375-724249020 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-Aurora/sha512/dba93510d06f71eec904f037521a7a5660f08aade329d88f2c72e68e8548e3795e6479876f3672b0141f510e767c3ea63740c4bdbd456bdc3d0bf3fe03bf1112", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db04f4da3c8695849eae8eeadcaddf4e64c04e3ac70233b8074e01054cf2929b9fd58c0551fb7ded2c7bbe7e686ff1448e5e09ccf6f977d1843f123451c4b79"} build_url:https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/G4zro45HQDSo-mM3mmyFDg/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dba93510d06f71eec904f037521a7a5660f08aade329d88f2c72e68e8548e3795e6479876f3672b0141f510e767c3ea63740c4bdbd456bdc3d0bf3fe03bf1112", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7db04f4da3c8695849eae8eeadcaddf4e64c04e3ac70233b8074e01054cf2929b9fd58c0551fb7ded2c7bbe7e686ff1448e5e09ccf6f977d1843f123451c4b79"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 03:53:12.357457) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:53:12.357807) ========= 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=d2a8c569965ab8367867b893000001a1-1463823591.129375-724249020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 03:53:12.441498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 03:53:12.441838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 03:53:12.442174) ========= ========= Total master_lag: 0.17 =========