builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1460988494.95 results: success (0) buildid: 20160418043044 builduid: 39a9e240edd74a1e886c9e030e1ef61e revision: bc5264d6536ed11cc513fd003453e0a91a3f45ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:14.950858) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:14.951474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-18 07:08:14.951932) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-18 07:08:16.028614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:16.029033) ========= 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=574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 07:08:16-- 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% 41.8M=0s 2016-04-18 07:08:16 (41.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171939 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:16.259462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:16.259762) ========= 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=574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.222240 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:16.497214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:16.497630) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bc5264d6536ed11cc513fd003453e0a91a3f45ca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bc5264d6536ed11cc513fd003453e0a91a3f45ca --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=574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 07:08:16,569 truncating revision to first 12 chars 2016-04-18 07:08:16,569 Setting DEBUG logging. 2016-04-18 07:08:16,569 attempt 1/10 2016-04-18 07:08:16,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/bc5264d6536e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 07:08:16,839 unpacking tar archive at: mozilla-inbound-bc5264d6536e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:17.079922) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:17.080281) ========= script_repo_revision: bc5264d6536ed11cc513fd003453e0a91a3f45ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:17.080695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:17.080972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:08:17.102160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-18 07:08:17.102576) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:08:17 INFO - MultiFileLogger online at 20160418 07:08:17 in /builds/slave/test 07:08:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:08:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:08:17 INFO - {'append_to_log': False, 07:08:17 INFO - 'base_work_dir': '/builds/slave/test', 07:08:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:08:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:08:17 INFO - 'branch': 'Mozilla-Inbound', 07:08:17 INFO - 'buildbot_json_path': 'buildprops.json', 07:08:17 INFO - 'config_files': ('talos/linux_config.py',), 07:08:17 INFO - 'default_actions': ('clobber', 07:08:17 INFO - 'read-buildbot-config', 07:08:17 INFO - 'download-and-extract', 07:08:17 INFO - 'populate-webroot', 07:08:17 INFO - 'create-virtualenv', 07:08:17 INFO - 'install', 07:08:17 INFO - 'run-tests'), 07:08:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:08:17 INFO - 'download_minidump_stackwalk': True, 07:08:17 INFO - 'download_symbols': 'ondemand', 07:08:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:08:17 INFO - 'tooltool.py': '/tools/tooltool.py', 07:08:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:08:17 INFO - '/tools/misc-python/virtualenv.py')}, 07:08:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:08:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:08:17 INFO - 'installer_path': 'installer.exe', 07:08:17 INFO - 'log_level': 'info', 07:08:17 INFO - 'log_name': 'talos', 07:08:17 INFO - 'log_to_console': True, 07:08:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:08:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:08:17 INFO - 'opt_config_files': (), 07:08:17 INFO - 'pip_index': False, 07:08:17 INFO - 'sps_profile': False, 07:08:17 INFO - 'sps_profile_interval': 0, 07:08:17 INFO - 'suite': 'dromaeojs', 07:08:17 INFO - 'system_bits': '32', 07:08:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:08:17 INFO - 'title': 'talos-linux64-ix-044', 07:08:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:08:17 INFO - 'use_talos_json': True, 07:08:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:08:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:08:17 INFO - 'work_dir': 'build'} 07:08:17 INFO - ##### 07:08:17 INFO - ##### Running clobber step. 07:08:17 INFO - ##### 07:08:17 INFO - Running pre-action listener: _resource_record_pre_action 07:08:17 INFO - Running main action method: clobber 07:08:17 INFO - rmtree: /builds/slave/test/build 07:08:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:08:19 INFO - Running post-action listener: _resource_record_post_action 07:08:19 INFO - ##### 07:08:19 INFO - ##### Running read-buildbot-config step. 07:08:19 INFO - ##### 07:08:19 INFO - Running pre-action listener: _resource_record_pre_action 07:08:19 INFO - Running main action method: read_buildbot_config 07:08:19 INFO - Using buildbot properties: 07:08:19 INFO - { 07:08:19 INFO - "project": "", 07:08:19 INFO - "product": "firefox", 07:08:19 INFO - "script_repo_revision": "production", 07:08:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:08:19 INFO - "repository": "", 07:08:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:08:19 INFO - "buildid": "20160418043044", 07:08:19 INFO - "pgo_build": "True", 07:08:19 INFO - "basedir": "/builds/slave/test", 07:08:19 INFO - "buildnumber": 1730, 07:08:19 INFO - "slavename": "talos-linux64-ix-044", 07:08:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:08:19 INFO - "platform": "ubuntu64_hw", 07:08:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:08:19 INFO - "branch": "mozilla-inbound", 07:08:19 INFO - "repo_path": "integration/mozilla-inbound", 07:08:19 INFO - "revision": "bc5264d6536ed11cc513fd003453e0a91a3f45ca", 07:08:19 INFO - "stage_platform": "linux64-pgo", 07:08:19 INFO - "builduid": "39a9e240edd74a1e886c9e030e1ef61e", 07:08:19 INFO - "slavebuilddir": "test" 07:08:19 INFO - } 07:08:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:08:19 INFO - Running post-action listener: _resource_record_post_action 07:08:19 INFO - ##### 07:08:19 INFO - ##### Running download-and-extract step. 07:08:19 INFO - ##### 07:08:19 INFO - Running pre-action listener: _resource_record_pre_action 07:08:19 INFO - Running main action method: download_and_extract 07:08:19 INFO - mkdir: /builds/slave/test/build/tests 07:08:19 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')]} 07:08:19 INFO - https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:08:23 INFO - Downloaded 1361 bytes. 07:08:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:08:23 INFO - Using the following test package requirements: 07:08:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:08:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:08:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'jsshell-linux-x86_64.zip'], 07:08:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:08:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:08:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:08:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:08:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:08:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:08:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:08:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:23 INFO - https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:28 INFO - Downloaded 23779414 bytes. 07:08:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:08:29 INFO - Return code: 0 07:08:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:08:29 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')]} 07:08:29 INFO - https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:08:31 INFO - Downloaded 23779414 bytes. 07:08:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:08:32 INFO - Return code: 0 07:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:32 INFO - https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:08:33 INFO - Downloaded 10845952 bytes. 07:08:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:08:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:08:34 INFO - Return code: 0 07:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:34 INFO - https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:08:35 INFO - Downloaded 58232301 bytes. 07:08:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:35 INFO - mkdir: /builds/slave/test/properties 07:08:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:08:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:08:35 INFO - Contents: 07:08:35 INFO - build_url:https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:08:36 INFO - Running post-action listener: _resource_record_post_action 07:08:36 INFO - Running post-action listener: set_extra_try_arguments 07:08:36 INFO - ##### 07:08:36 INFO - ##### Running populate-webroot step. 07:08:36 INFO - ##### 07:08:36 INFO - Running pre-action listener: _resource_record_pre_action 07:08:36 INFO - Running main action method: populate_webroot 07:08:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:08:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:08:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:08:36 INFO - '--tppagecycles', 07:08:36 INFO - '7'], 07:08:36 INFO - 'tests': ['tsvgm']}}, 07:08:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:08:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:08:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:08:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:08:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:08:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['damp', 'tps']}, 07:08:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'tests': ['damp', 'tps']}, 07:08:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['dromaeo_dom']}, 07:08:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:08:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['a11yr', 07:08:36 INFO - 'ts_paint', 07:08:36 INFO - 'tpaint', 07:08:36 INFO - 'sessionrestore', 07:08:36 INFO - 'sessionrestore_no_auto_restore', 07:08:36 INFO - 'tabpaint']}, 07:08:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:08:36 INFO - 'ts_paint', 07:08:36 INFO - 'tpaint', 07:08:36 INFO - 'sessionrestore', 07:08:36 INFO - 'sessionrestore_no_auto_restore', 07:08:36 INFO - 'tabpaint']}, 07:08:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:08:36 INFO - 'ts_paint', 07:08:36 INFO - 'tpaint', 07:08:36 INFO - 'sessionrestore', 07:08:36 INFO - 'sessionrestore_no_auto_restore', 07:08:36 INFO - 'tabpaint']}, 07:08:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:08:36 INFO - 'ts_paint', 07:08:36 INFO - 'tpaint', 07:08:36 INFO - 'sessionrestore', 07:08:36 INFO - 'sessionrestore_no_auto_restore', 07:08:36 INFO - 'tabpaint']}, 07:08:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['a11yr', 07:08:36 INFO - 'ts_paint', 07:08:36 INFO - 'tpaint', 07:08:36 INFO - 'sessionrestore', 07:08:36 INFO - 'sessionrestore_no_auto_restore', 07:08:36 INFO - 'tabpaint']}, 07:08:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['a11yr', 07:08:36 INFO - 'ts_paint', 07:08:36 INFO - 'tpaint', 07:08:36 INFO - 'sessionrestore', 07:08:36 INFO - 'sessionrestore_no_auto_restore', 07:08:36 INFO - 'tabpaint']}, 07:08:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['tsvgx', 07:08:36 INFO - 'tsvgr_opacity', 07:08:36 INFO - 'tart', 07:08:36 INFO - 'tscrollx', 07:08:36 INFO - 'cart']}, 07:08:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:08:36 INFO - 'tsvgr_opacity', 07:08:36 INFO - 'tart', 07:08:36 INFO - 'tscrollx', 07:08:36 INFO - 'cart']}, 07:08:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'talos_options': ['--disable-e10s'], 07:08:36 INFO - 'tests': ['tp5o']}, 07:08:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'tests': ['tp5o']}, 07:08:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'talos_options': ['--disable-e10s', 07:08:36 INFO - '--xperf_path', 07:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:36 INFO - 'tests': ['tp5n']}, 07:08:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:08:36 INFO - 'talos_options': ['--xperf_path', 07:08:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:08:36 INFO - 'tests': ['tp5n']}}, 07:08:36 INFO - 'talos.zip': {'path': '', 07:08:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:08:36 INFO - Running post-action listener: _resource_record_post_action 07:08:36 INFO - ##### 07:08:36 INFO - ##### Running create-virtualenv step. 07:08:36 INFO - ##### 07:08:36 INFO - Running pre-action listener: _resource_record_pre_action 07:08:36 INFO - Running main action method: create_virtualenv 07:08:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:08:36 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 07:08:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:08:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:08:36 INFO - Using real prefix '/usr' 07:08:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:08:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:08:40 INFO - Installing pip.................done. 07:08:40 INFO - Return code: 0 07:08:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:08:40 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')]} 07:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:40 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')]} 07:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:40 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:40 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 07:08:40 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 07:08:40 INFO - Using env: {'DISPLAY': ':0', 07:08:40 INFO - 'HOME': '/home/cltbld', 07:08:40 INFO - 'LANG': 'en_US.UTF-8', 07:08:40 INFO - 'LANGUAGE': 'en_US:en', 07:08:40 INFO - 'LOGNAME': 'cltbld', 07:08:40 INFO - 'MAIL': '/var/mail/cltbld', 07:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:40 INFO - 'MOZ_NO_REMOTE': '1', 07:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:40 INFO - 'NO_EM_RESTART': '1', 07:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:40 INFO - 'PWD': '/builds/slave/test', 07:08:40 INFO - 'SHELL': '/bin/bash', 07:08:40 INFO - 'SHLVL': '1', 07:08:40 INFO - 'TERM': 'linux', 07:08:40 INFO - 'TMOUT': '86400', 07:08:40 INFO - 'USER': 'cltbld', 07:08:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:40 INFO - '_': '/tools/buildbot/bin/python'} 07:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:41 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 07:08:41 INFO - Cleaning up... 07:08:41 INFO - Return code: 0 07:08:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:08: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')]} 07:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08: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')]} 07:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:08:41 INFO - Using env: {'DISPLAY': ':0', 07:08:41 INFO - 'HOME': '/home/cltbld', 07:08:41 INFO - 'LANG': 'en_US.UTF-8', 07:08:41 INFO - 'LANGUAGE': 'en_US:en', 07:08:41 INFO - 'LOGNAME': 'cltbld', 07:08:41 INFO - 'MAIL': '/var/mail/cltbld', 07:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:41 INFO - 'MOZ_NO_REMOTE': '1', 07:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:41 INFO - 'NO_EM_RESTART': '1', 07:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:41 INFO - 'PWD': '/builds/slave/test', 07:08:41 INFO - 'SHELL': '/bin/bash', 07:08:41 INFO - 'SHLVL': '1', 07:08:41 INFO - 'TERM': 'linux', 07:08:41 INFO - 'TMOUT': '86400', 07:08:41 INFO - 'USER': 'cltbld', 07:08:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:41 INFO - '_': '/tools/buildbot/bin/python'} 07:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:41 INFO - Downloading/unpacking psutil>=0.7.1 07:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:43 INFO - Installing collected packages: psutil 07:08:43 INFO - Running setup.py install for psutil 07:08:43 INFO - building 'psutil._psutil_linux' extension 07:08:43 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 07:08:45 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 07:08:45 INFO - building 'psutil._psutil_posix' extension 07:08:45 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 07:08:45 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 07:08:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:08:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:08:45 INFO - Successfully installed psutil 07:08:45 INFO - Cleaning up... 07:08:45 INFO - Return code: 0 07:08:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:45 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:45 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 07:08:45 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 07:08:45 INFO - Using env: {'DISPLAY': ':0', 07:08:45 INFO - 'HOME': '/home/cltbld', 07:08:45 INFO - 'LANG': 'en_US.UTF-8', 07:08:45 INFO - 'LANGUAGE': 'en_US:en', 07:08:45 INFO - 'LOGNAME': 'cltbld', 07:08:45 INFO - 'MAIL': '/var/mail/cltbld', 07:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:45 INFO - 'MOZ_NO_REMOTE': '1', 07:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:45 INFO - 'NO_EM_RESTART': '1', 07:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:45 INFO - 'PWD': '/builds/slave/test', 07:08:45 INFO - 'SHELL': '/bin/bash', 07:08:45 INFO - 'SHLVL': '1', 07:08:45 INFO - 'TERM': 'linux', 07:08:45 INFO - 'TMOUT': '86400', 07:08:45 INFO - 'USER': 'cltbld', 07:08:45 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:45 INFO - '_': '/tools/buildbot/bin/python'} 07:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:08:47 INFO - Installing collected packages: mozsystemmonitor 07:08:47 INFO - Running setup.py install for mozsystemmonitor 07:08:47 INFO - Successfully installed mozsystemmonitor 07:08:47 INFO - Cleaning up... 07:08:48 INFO - Return code: 0 07:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:48 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:48 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 07:08:48 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 07:08:48 INFO - Using env: {'DISPLAY': ':0', 07:08:48 INFO - 'HOME': '/home/cltbld', 07:08:48 INFO - 'LANG': 'en_US.UTF-8', 07:08:48 INFO - 'LANGUAGE': 'en_US:en', 07:08:48 INFO - 'LOGNAME': 'cltbld', 07:08:48 INFO - 'MAIL': '/var/mail/cltbld', 07:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:48 INFO - 'MOZ_NO_REMOTE': '1', 07:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:48 INFO - 'NO_EM_RESTART': '1', 07:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:48 INFO - 'PWD': '/builds/slave/test', 07:08:48 INFO - 'SHELL': '/bin/bash', 07:08:48 INFO - 'SHLVL': '1', 07:08:48 INFO - 'TERM': 'linux', 07:08:48 INFO - 'TMOUT': '86400', 07:08:48 INFO - 'USER': 'cltbld', 07:08:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:48 INFO - '_': '/tools/buildbot/bin/python'} 07:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:08:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 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 07:08:50 INFO - Downloading docopt-0.6.1.tar.gz 07:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:08:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:08:50 INFO - Running setup.py install for blobuploader 07:08:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:08:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:08:50 INFO - Running setup.py install for requests 07:08:51 INFO - Running setup.py install for docopt 07:08:51 INFO - Successfully installed blobuploader requests docopt 07:08:51 INFO - Cleaning up... 07:08:51 INFO - Return code: 0 07:08:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:51 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')]} 07:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:51 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')]} 07:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:51 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:51 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 07:08:51 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 07:08:51 INFO - Using env: {'DISPLAY': ':0', 07:08:51 INFO - 'HOME': '/home/cltbld', 07:08:51 INFO - 'LANG': 'en_US.UTF-8', 07:08:51 INFO - 'LANGUAGE': 'en_US:en', 07:08:51 INFO - 'LOGNAME': 'cltbld', 07:08:51 INFO - 'MAIL': '/var/mail/cltbld', 07:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:51 INFO - 'MOZ_NO_REMOTE': '1', 07:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:51 INFO - 'NO_EM_RESTART': '1', 07:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:51 INFO - 'PWD': '/builds/slave/test', 07:08:51 INFO - 'SHELL': '/bin/bash', 07:08:51 INFO - 'SHLVL': '1', 07:08:51 INFO - 'TERM': 'linux', 07:08:51 INFO - 'TMOUT': '86400', 07:08:51 INFO - 'USER': 'cltbld', 07:08:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:51 INFO - '_': '/tools/buildbot/bin/python'} 07:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:51 INFO - Running setup.py (path:/tmp/pip-KseVl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:51 INFO - Running setup.py (path:/tmp/pip-lUk77P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:51 INFO - Running setup.py (path:/tmp/pip-qUB_km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:51 INFO - Running setup.py (path:/tmp/pip-rbuCKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:51 INFO - Running setup.py (path:/tmp/pip-OlmFo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:52 INFO - Running setup.py (path:/tmp/pip-NshE7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:52 INFO - Running setup.py (path:/tmp/pip-KI1J5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:52 INFO - Running setup.py (path:/tmp/pip-wCPWGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:52 INFO - Running setup.py (path:/tmp/pip-zDeDWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:52 INFO - Running setup.py (path:/tmp/pip-3agxPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:52 INFO - Running setup.py (path:/tmp/pip-AsZca8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:52 INFO - Running setup.py (path:/tmp/pip-YQhVyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:52 INFO - Running setup.py (path:/tmp/pip-36cKbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:52 INFO - Running setup.py (path:/tmp/pip-3b4s__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:52 INFO - Running setup.py (path:/tmp/pip-40PJs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:52 INFO - Running setup.py (path:/tmp/pip-0KJX9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:52 INFO - Running setup.py (path:/tmp/pip-Z31tzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:08:52 INFO - Running setup.py install for manifestparser 07:08:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Running setup.py install for mozcrash 07:08:53 INFO - Running setup.py install for mozdebug 07:08:53 INFO - Running setup.py install for mozdevice 07:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Running setup.py install for mozfile 07:08:53 INFO - Running setup.py install for mozhttpd 07:08:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Running setup.py install for mozinfo 07:08:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Running setup.py install for mozInstall 07:08:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Running setup.py install for mozleak 07:08:53 INFO - Running setup.py install for mozlog 07:08:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:08:53 INFO - Running setup.py install for moznetwork 07:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Running setup.py install for mozprocess 07:08:54 INFO - Running setup.py install for mozprofile 07:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Running setup.py install for mozrunner 07:08:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Running setup.py install for mozscreenshot 07:08:54 INFO - Running setup.py install for moztest 07:08:54 INFO - Running setup.py install for mozversion 07:08:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:08:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:08:54 INFO - Cleaning up... 07:08:54 INFO - Return code: 0 07:08:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:54 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')]} 07:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:54 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')]} 07:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:54 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:54 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 07:08:54 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 07:08:54 INFO - Using env: {'DISPLAY': ':0', 07:08:54 INFO - 'HOME': '/home/cltbld', 07:08:54 INFO - 'LANG': 'en_US.UTF-8', 07:08:54 INFO - 'LANGUAGE': 'en_US:en', 07:08:54 INFO - 'LOGNAME': 'cltbld', 07:08:54 INFO - 'MAIL': '/var/mail/cltbld', 07:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:54 INFO - 'MOZ_NO_REMOTE': '1', 07:08:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:54 INFO - 'NO_EM_RESTART': '1', 07:08:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:54 INFO - 'PWD': '/builds/slave/test', 07:08:54 INFO - 'SHELL': '/bin/bash', 07:08:54 INFO - 'SHLVL': '1', 07:08:54 INFO - 'TERM': 'linux', 07:08:54 INFO - 'TMOUT': '86400', 07:08:54 INFO - 'USER': 'cltbld', 07:08:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:54 INFO - '_': '/tools/buildbot/bin/python'} 07:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:08:54 INFO - Running setup.py (path:/tmp/pip-mh5mRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:08:55 INFO - Running setup.py (path:/tmp/pip-a5Fjsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:08:55 INFO - Running setup.py (path:/tmp/pip-IDdGH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:08:55 INFO - Running setup.py (path:/tmp/pip-dAZH4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:08:55 INFO - Running setup.py (path:/tmp/pip-NgC0Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:08:55 INFO - Running setup.py (path:/tmp/pip-J3y2cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:08:55 INFO - Running setup.py (path:/tmp/pip-h6QliA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:08:55 INFO - Running setup.py (path:/tmp/pip-U7ro4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:08:55 INFO - Running setup.py (path:/tmp/pip-IH2XOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:08:55 INFO - Running setup.py (path:/tmp/pip-xQtgYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:08:55 INFO - Running setup.py (path:/tmp/pip-9zNxR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:08:55 INFO - Running setup.py (path:/tmp/pip-_dMh67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:08:55 INFO - Running setup.py (path:/tmp/pip-N_YGib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:08:55 INFO - Running setup.py (path:/tmp/pip-4Z4SOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:08:55 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)) 07:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:55 INFO - Running setup.py (path:/tmp/pip-rBYeVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:08:56 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)) 07:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:08:56 INFO - Running setup.py (path:/tmp/pip-WBbIfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:08:56 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)) 07:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:08:56 INFO - Running setup.py (path:/tmp/pip-S0q1Ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:08:56 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)) 07:08:56 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)) 07:08:56 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)) 07:08:56 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)) 07:08:56 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)) 07:08:56 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)) 07:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:08:58 INFO - Downloading blessings-1.6.tar.gz 07:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:08:58 INFO - Installing collected packages: blessings 07:08:58 INFO - Running setup.py install for blessings 07:08:58 INFO - Successfully installed blessings 07:08:58 INFO - Cleaning up... 07:08:58 INFO - Return code: 0 07:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:08:58 INFO - Reading from file tmpfile_stdout 07:08:58 INFO - Current package versions: 07:08:58 INFO - argparse == 1.2.1 07:08:58 INFO - blessings == 1.6 07:08:58 INFO - blobuploader == 1.2.4 07:08:58 INFO - docopt == 0.6.1 07:08:58 INFO - manifestparser == 1.1 07:08:58 INFO - mozInstall == 1.12 07:08:58 INFO - mozcrash == 0.17 07:08:58 INFO - mozdebug == 0.1 07:08:58 INFO - mozdevice == 0.48 07:08:58 INFO - mozfile == 1.2 07:08:58 INFO - mozhttpd == 0.7 07:08:58 INFO - mozinfo == 0.9 07:08:58 INFO - mozleak == 0.1 07:08:58 INFO - mozlog == 3.1 07:08:58 INFO - moznetwork == 0.27 07:08:58 INFO - mozprocess == 0.22 07:08:58 INFO - mozprofile == 0.28 07:08:58 INFO - mozrunner == 6.11 07:08:58 INFO - mozscreenshot == 0.1 07:08:58 INFO - mozsystemmonitor == 0.0 07:08:58 INFO - moztest == 0.7 07:08:58 INFO - mozversion == 1.4 07:08:58 INFO - psutil == 3.1.1 07:08:58 INFO - requests == 1.2.3 07:08:58 INFO - wsgiref == 0.1.2 07:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:08:58 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')]} 07:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:58 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')]} 07:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:58 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:58 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 07:08:58 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 07:08:58 INFO - Using env: {'DISPLAY': ':0', 07:08:58 INFO - 'HOME': '/home/cltbld', 07:08:58 INFO - 'LANG': 'en_US.UTF-8', 07:08:58 INFO - 'LANGUAGE': 'en_US:en', 07:08:58 INFO - 'LOGNAME': 'cltbld', 07:08:58 INFO - 'MAIL': '/var/mail/cltbld', 07:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:58 INFO - 'MOZ_NO_REMOTE': '1', 07:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:58 INFO - 'NO_EM_RESTART': '1', 07:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:58 INFO - 'PWD': '/builds/slave/test', 07:08:58 INFO - 'SHELL': '/bin/bash', 07:08:58 INFO - 'SHLVL': '1', 07:08:58 INFO - 'TERM': 'linux', 07:08:58 INFO - 'TMOUT': '86400', 07:08:58 INFO - 'USER': 'cltbld', 07:08:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:58 INFO - '_': '/tools/buildbot/bin/python'} 07:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 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)) 07:08:58 INFO - Cleaning up... 07:08:58 INFO - Return code: 0 07:08:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:08:58 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')]} 07:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:58 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')]} 07:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:08:58 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:08:58 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 07:08:58 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 07:08:58 INFO - Using env: {'DISPLAY': ':0', 07:08:58 INFO - 'HOME': '/home/cltbld', 07:08:58 INFO - 'LANG': 'en_US.UTF-8', 07:08:58 INFO - 'LANGUAGE': 'en_US:en', 07:08:58 INFO - 'LOGNAME': 'cltbld', 07:08:58 INFO - 'MAIL': '/var/mail/cltbld', 07:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:08:58 INFO - 'MOZ_NO_REMOTE': '1', 07:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:08:58 INFO - 'NO_EM_RESTART': '1', 07:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:08:58 INFO - 'PWD': '/builds/slave/test', 07:08:58 INFO - 'SHELL': '/bin/bash', 07:08:58 INFO - 'SHLVL': '1', 07:08:58 INFO - 'TERM': 'linux', 07:08:58 INFO - 'TMOUT': '86400', 07:08:58 INFO - 'USER': 'cltbld', 07:08:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:08:58 INFO - '_': '/tools/buildbot/bin/python'} 07:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:08:58 INFO - Downloading/unpacking jsonschema 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:08:58 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 07:09:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:00 INFO - Downloading/unpacking functools32 (from jsonschema) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:01 INFO - warning: no files found matching '*.txt' 07:09:01 INFO - no previously-included directories found matching 'build' 07:09:01 INFO - no previously-included directories found matching 'dist' 07:09:01 INFO - no previously-included directories found matching '.git*' 07:09:01 INFO - Installing collected packages: jsonschema, functools32 07:09:01 INFO - Running setup.py install for functools32 07:09:01 INFO - warning: no files found matching '*.txt' 07:09:01 INFO - no previously-included directories found matching 'build' 07:09:01 INFO - no previously-included directories found matching 'dist' 07:09:01 INFO - no previously-included directories found matching '.git*' 07:09:01 INFO - Successfully installed jsonschema functools32 07:09:01 INFO - Cleaning up... 07:09:01 INFO - Return code: 0 07:09:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:09:01 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')]} 07:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:01 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')]} 07:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:01 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 0x7f0f136aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, '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': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', '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 07:09:01 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 07:09:01 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 07:09:01 INFO - Using env: {'DISPLAY': ':0', 07:09:01 INFO - 'HOME': '/home/cltbld', 07:09:01 INFO - 'LANG': 'en_US.UTF-8', 07:09:01 INFO - 'LANGUAGE': 'en_US:en', 07:09:01 INFO - 'LOGNAME': 'cltbld', 07:09:01 INFO - 'MAIL': '/var/mail/cltbld', 07:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:01 INFO - 'MOZ_NO_REMOTE': '1', 07:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:01 INFO - 'NO_EM_RESTART': '1', 07:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:01 INFO - 'PWD': '/builds/slave/test', 07:09:01 INFO - 'SHELL': '/bin/bash', 07:09:01 INFO - 'SHLVL': '1', 07:09:01 INFO - 'TERM': 'linux', 07:09:01 INFO - 'TMOUT': '86400', 07:09:01 INFO - 'USER': 'cltbld', 07:09:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:01 INFO - '_': '/tools/buildbot/bin/python'} 07:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:01 INFO - Downloading/unpacking flake8 07:09:01 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 07:09:01 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 07:09:01 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 07:09:01 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 07:09:01 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 07:09:01 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 07:09:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:09:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:09:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:04 INFO - no previously-included directories found matching 'docs/_build' 07:09:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:09:04 INFO - Running setup.py install for pep8 07:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:09:04 INFO - no previously-included directories found matching 'docs/_build' 07:09:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:09:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:09:04 INFO - Cleaning up... 07:09:04 INFO - Return code: 0 07:09:04 INFO - Running post-action listener: _resource_record_post_action 07:09:04 INFO - Running post-action listener: _start_resource_monitoring 07:09:04 INFO - Starting resource monitoring. 07:09:04 INFO - ##### 07:09:04 INFO - ##### Running install step. 07:09:04 INFO - ##### 07:09:04 INFO - Running pre-action listener: _resource_record_pre_action 07:09:04 INFO - Running main action method: install 07:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:04 INFO - Reading from file tmpfile_stdout 07:09:04 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:04 INFO - Reading from file tmpfile_stdout 07:09:04 INFO - Output received: 07:09:04 INFO - Usage: mozinstall [options] installer 07:09:04 INFO - Options: 07:09:04 INFO - -h, --help show this help message and exit 07:09:04 INFO - -d DEST, --destination=DEST 07:09:04 INFO - Directory to install application into. [default: 07:09:04 INFO - "/builds/slave/test"] 07:09:04 INFO - --app=APP Application being installed. [default: firefox] 07:09:04 INFO - mkdir: /builds/slave/test/build/application 07:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:09:21 INFO - Reading from file tmpfile_stdout 07:09:21 INFO - Output received: 07:09:21 INFO - /builds/slave/test/build/application/firefox/firefox 07:09:21 INFO - Running post-action listener: _resource_record_post_action 07:09:21 INFO - ##### 07:09:21 INFO - ##### Running run-tests step. 07:09:21 INFO - ##### 07:09:21 INFO - Running pre-action listener: _resource_record_pre_action 07:09:21 INFO - Running main action method: run_tests 07:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:09:21 INFO - Python 2.7.3 07:09:21 INFO - Return code: 0 07:09:21 INFO - grabbing minidump binary from tooltool 07:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:21 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 0x1380410>, '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 0x1381310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13817a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:09:21 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 07:09:21 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 07:09:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:09:21 INFO - Return code: 0 07:09:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:09:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:09:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:09:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:09:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:09:22 INFO - Return code: 0 07:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:09:22 INFO - Using env: {'DISPLAY': ':0', 07:09:22 INFO - 'HOME': '/home/cltbld', 07:09:22 INFO - 'LANG': 'en_US.UTF-8', 07:09:22 INFO - 'LANGUAGE': 'en_US:en', 07:09:22 INFO - 'LOGNAME': 'cltbld', 07:09:22 INFO - 'MAIL': '/var/mail/cltbld', 07:09:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:09:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:22 INFO - 'MOZ_NO_REMOTE': '1', 07:09:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:22 INFO - 'NO_EM_RESTART': '1', 07:09:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:22 INFO - 'PWD': '/builds/slave/test', 07:09:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:09:22 INFO - 'SHELL': '/bin/bash', 07:09:22 INFO - 'SHLVL': '1', 07:09:22 INFO - 'TERM': 'linux', 07:09:22 INFO - 'TMOUT': '86400', 07:09:22 INFO - 'USER': 'cltbld', 07:09:22 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942', 07:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:22 INFO - '_': '/tools/buildbot/bin/python'} 07:09:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:09:22 INFO - mozversion application_buildid: 20160418043044 07:09:22 INFO - mozversion application_changeset: bc5264d6536ed11cc513fd003453e0a91a3f45ca 07:09:22 INFO - mozversion application_display_name: Nightly 07:09:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:09:22 INFO - mozversion application_name: Firefox 07:09:22 INFO - mozversion application_remotingname: firefox 07:09:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:09:22 INFO - mozversion application_vendor: Mozilla 07:09:22 INFO - mozversion application_version: 48.0a1 07:09:22 INFO - mozversion platform_buildid: 20160418043044 07:09:22 INFO - mozversion platform_changeset: bc5264d6536ed11cc513fd003453e0a91a3f45ca 07:09:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:09:22 INFO - mozversion platform_version: 48.0a1 07:09:22 INFO - using testdate: 1460988562 07:09:22 INFO - actual date: 1460988562 07:09:22 INFO - starting webserver on 'localhost:57398' 07:09:22 INFO - SUITE-START | Running 2 tests 07:09:22 INFO - TEST-START | dromaeo_css 07:09:22 INFO - operating with platform_type : linux_ 07:09:22 INFO - Initialising browser for dromaeo_css test... 07:09:22 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wGA4X/profile http://localhost:57398/getInfo.html) 07:09:27 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 07:09:27 INFO - PROCESS | 3316 | colorDepth:24 07:09:27 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 07:09:27 INFO - PROCESS | 3316 | __metrics 07:09:28 ERROR - PROCESS | 3316 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:09:29 INFO - TEST-INFO | 3316: exit 0 07:09:29 INFO - Browser initialized. 07:09:29 INFO - Running cycle 1/1 for dromaeo_css test... 07:09:29 INFO - TEST-INFO | started process 3399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8wGA4X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:41 INFO - PROCESS | 3399 | RSS: Main: 153358336 07:09:41 INFO - PROCESS | 3399 | 07:10:32 INFO - PROCESS | 3399 | 1460988632221 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] 07:12:39 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:57398/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57398/tests/dromaeo/cssquery-ext.html) 07:12:41 INFO - PROCESS | 3399 | RSS: Main: 280391680 07:12:41 INFO - PROCESS | 3399 | 07:15:43 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:57398/tests/dromaeo/cssquery-ext.html (next: http://localhost:57398/tests/dromaeo/cssquery-jquery.html) 07:15:43 INFO - PROCESS | 3399 | RSS: Main: 234455040 07:15:43 INFO - PROCESS | 3399 | 07:18:45 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:57398/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57398/tests/dromaeo/cssquery-mootools.html) 07:18:46 INFO - PROCESS | 3399 | RSS: Main: 234315776 07:18:46 INFO - PROCESS | 3399 | 07:21:48 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:57398/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57398/tests/dromaeo/cssquery-prototype.html) 07:21:48 INFO - PROCESS | 3399 | RSS: Main: 232267776 07:21:48 INFO - PROCESS | 3399 | 07:24:51 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:57398/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57398/tests/dromaeo/cssquery-yui.html) 07:24:52 INFO - PROCESS | 3399 | RSS: Main: 206618624 07:24:52 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | Cycle 1(1): loaded http://localhost:57398/tests/dromaeo/cssquery-yui.html (next: http://localhost:57398/tests/dromaeo/cssquery-dojo.html) 07:27:54 INFO - PROCESS | 3399 | RSS: Main: 269111296 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | __start_tp_report 07:27:54 INFO - PROCESS | 3399 | _x_x_mozilla_page_load 07:27:54 INFO - PROCESS | 3399 | _x_x_mozilla_page_load_details 07:27:54 INFO - PROCESS | 3399 | |i|pagename|runs| 07:27:54 INFO - PROCESS | 3399 | |0;dojo.html;3036.83297418642;3087.9536806947913;3128.3430479599283;3130.5617213590085;3157.084445510802;5134.486551344864;5255.658382205159;5264.157734762439;5295.099833028385;5301.840944771653;5268.446813084628;5277.656952298098;5280.815171468999;5282.022825777224;5323.653962492445;4787.640926930477;4799.688020278688;4820.879478013043;4841.128596852565;4952.03435330109;4809.158397280479;4818.204996175627;4822.855314340575;4827.275908613701;4828;4740.336352910595;4766.594839438651;4793.832215872428;4848.321235027064;4863.197572400567;4740.597049250818;4752.144613969484;4773.546513081252;4825.541573550507;4895.657303988723;4755.952440475586;4766.022965292107;4778.187708089633;4789.137955168068;4832.251001094836;5128.333316668846;5189.844304670866;5193.63644544882;5217.34783152106;5249.527542521153;5587.7485513152005;5611.270534830487;5618.634788738719;5658;5676.574256930706;5688.857778555528;5719.571032172604;5740.913886291709;5741.856453588652;5744.856378590527;5245.370555533323;5270;5358.678479291255;5361.142217245261;5362.4637536246455;5709.51469125129;5710.086386178192;5714.085746280575;5755.136729490526;5758.309002919593;5455.236266922634;5459.672419654833;5461.2627295315415;5492.80775172867;5526.226328314039;5517;5573.860653483695;5577.8047768327915;5583.497485226268;5587.1339942309005;5671.489565939003;5696.174054762119;5723.456271654186;5725.255716756878;5774.018416869142;5555.527780138734;5559.583031272671;5571.303587051619;5585.972070139624;5601.747921343549;4220.493540775126;4263.360495925574;4271.850485233002;4289.721168124062;4313.9137217255475;3813.122981714221;3814.9809250953567;3844.750091244116;3865.323568375523;3879.0884142226555;5304.708241046779;5327.946720532823;5336.973315133399;5346.705931173823;5371.409144994048;5453.345598528202;5641.943580564224;5670.829875103754;5730.885382292414;5840.415958404211;5355.973220133952;5367.060764366221;5370.140777475585;5388.434214407431;5390.05674007055;4740.1230772307235;4770.451398089194;4772.5227477252;4780.665353425227;4823.614110871122;5783.797567085132;5826.446487583673;5834.824955251349;5927.970360148258;5929.169916211734;5668.943310566924;5688.459596338341;5693.572982026281;5699.572532060195;5717.371089180104;5859.296884373732;5863.032599621015;5877.823665290048;5881.235439392852;5894.322152952293;5377.8924421510565;5503.422140675331;5554.50009499147;5575.944240557543;5612.971935140298;5654.886902262014;5669.801556945487;5674.319081710221;5684.744186511534;5685.829425117253;5434.212039254365;5510.256115424367;5519.779208831763;5541.030319694118;5545.722713864371;5495.422980586981;5533.059379905506;5547.556195504269;5559.305086864142;5601.775928962796;5444;5450.754716037709;5484.725763711878;5496.367917689357;5500.367457742251;5533;5595.076812326083;5602.607817452739;5614.606977511535;5631.222620469965;5284.762185701576;5404.513593776579;5443.618946673695;5538.363088244742;5543.279373681396 07:27:54 INFO - PROCESS | 3399 | |1;ext.html;588.5644622978995;597.1371368372701;641.7048157847391;645.9838504037399;647.9384458476443;37809;38958;39029;39029;39043.80478097613;40871;41647.375289370684;41727;41762.58237417625;41841.37237941433;7115.501914865961;8635.179657932485;8866.379353445262;9996.550155242996;10296.897031029668;10190.847137292909;10389.376637401741;10394.37633741974;10411.271211015232;10423.68728938133;10427.478626068703;10514.737131571695;10517.474126293693;10518.21113416493;10526.631567895125;7473.290037446461;10088;10385.792284154275;10402.739931501697;10408.115310198642;9883.11052005323;9935.90064099357;10011.349262297927;10016.499175041292;10027.649032283907;38682.226355473016;39290.214195715926;39304.21391572181;39384.409233861516;39424.60575394238;3152.322250716084;3242.1408326793417;3321.667833216659;3466.532018177539;3503.7722548034553;32262.516062259085;32448.837755811306;32481.51277730836;32679;33180.170495737555;4351.804168812411;4411.691181617288;4417.8288814316675;4443.688941774077;4447.288433850601;300644;304100.9999999978;304157;304235;304566.47716761497;60986.39013609896;61285;61695.383046168965;61744.07383889245;61825;64150.67924660347;67133.664331679;69482;69656.30343696498;69670.65164674245;14648.560543183721;15837.524874253791;16136;16140.75788863168;16153.596160095856;10748.97884700952;11060.336379817236;11084.501197446134;11086.944565277123;11104.167187460973;19547.413577592695;20669.276575319793;20760.885867119752;20763.273285434938;20813.687794683094;7697.961510192413;7793.64928578204;7896.763097107096;7972.322352599978;8074.192580741878;1090.1660229924114;1095.39205740813;1111.6387174168428;1115.8493603363443;1175.2008634128874;31878.203044924063;32079.67920320767;32373.676263237536;32619.67380326214;33989.32021359559;1092.808758467265;1120.3389999899935;1146.415328182633;1174.1898090317654;1189.6371606660052;16383.83616163847;16506.917465412596;16662.666746665;16684.416045438353;16834.24245908937;476158;480811;482902;484439;489545;55667;56599;56638.43361566414;56673.71663141658;56721.7163914186;1215.392303848076;1347.9730405391838;1355.491690616019;1372.6431127906817;1434.0965191929017;27955.720442796126;28727.856360718062;28845.855770721013;29488.705112949454;29861;42498;45110.32334514919;46539;46663.30005049859;46714;442344;443936;447163;448925;452272;36850.44724329084;42756.35865461958;46744.29883551681;47504.52495475001;47659.57021289367;44441.11117777691;44725;44932.550674492835;45289.32066018946;45482.54517454783;37494.625053749114;37736.433953491265;38321.04197395087;38438;39102;37009;37485.625143749305;38371.80814095912;38397.424038638885;38810.41784373293;39589.40615890706;39725.404118938815;40118.398224027245;41418.792906035276;43410.131797364505;33691.494627581094;34650.30699385948;34855.12862178466;35054.64945350514;35366;25715.614265785654;26793.86603066972;27265.182044538695;27535.173944781687;27583.66717260926 07:27:54 INFO - PROCESS | 3399 | |2;jquery.html;392.2605887901306;396.26492855752593;402.5752830763543;404.2783631218276;406.35998302673295;13739.931300343509;17586.296548138092;17806.465806025808;18541.07294635268;18549.907250463762;15251.542453726379;15639.843601563982;15937.760933586005;16101.83898161018;16154;5420.512153906147;5527.060399732055;5663.037283661767;5703.914441283384;5710.77156913723;5589.972050139764;5602.635828671144;5626.859328516799;5634.464725851058;5649.604527683064;5136.203888397305;5460.590455715837;5566.415526369734;5607.299087614048;5611.8877622447735;5237.816676416345;5313.017091837984;5396.541293990015;5429.294191755086;5431.429699881534;5493.478119578634;5495.587830912697;5538.806141785059;5554.611177217596;5556.222128901957;12892;13071;16397.67204655912;21422.678659820114;21489.46276343104;2120.0353839003214;2150.7741687122784;2323.8257130715265;2357.599029106893;2391.629297458897;9542.33203675743;10084.69745907624;10154.949225253826;10169.694909152737;10353.585856565729;1885.1516817432073;1945.1160240273146;1986.414007867668;1987.9503012424661;2031.0048076442438;77769;79583.6020819898;79983;81888;81934.59032704799;10420.218483613608;10529.210309226839;10622.946885265525;10701.304415212986;10849.945750271356;12863.485460581473;13580.524681636096;15192.784577233795;15202.923985380003;15317.31072101758;5595.832125036255;5692.516136128393;6805.829854253683;7164.641767911584;7296.489245752747;6760.661966901635;6900.7929762107215;6920.9307906920285;7085.326893945067;7135.036770035978;4449.644028477714;4469.4189755332245;4535.80225940711;4593.19619066662;4666.346711460398;1764.9647007059787;1901.2490066423961;1949.3859434278156;1972.3491247888162;1992.5118346005322;914.6204325204966;976.272676855747;1015.3399192320609;1037.4138611684375;1054.8892366301582;17759.289628414976;17781;17914.641707166043;17928;18181.54546136357;932.1983094538691;943.556528431636;956.2636769687302;993.056596233581;1060.0512541275516;8245.381596380295;9916.157126644315;10065.496725163712;10177.592896284214;10265.589376425009;463489;469944;475247;481083;484816;78160.21839781642;92655.53672231731;96526;97423;100954.07696287123;1072.5227273863056;1078.8975047370486;1107.4241394474989;1112.6940091474746;1122.9909224070154;16483;16951.745723813907;16980.150992450082;17121.315147393965;17276.049817260173;29038.419231615673;36638.267234655694;38808.41787373135;38911.41632875566;40400.79799600983;42450.36324455074;51841.7407912958;51968.220476693634;53058.63296404302;57928.4207157923;8154.2253485918745;8239.752807415787;8245.299149572353;8393.496390216362;8462.069172391155;9342.859857102014;12441.626751197478;12704.555340563036;12724.1729287596;12740.362981850685;11102.444877756241;11708.243763435212;11795.410229488663;11869.109816763605;11970.521179152736;11028.558857645925;11295.37875416827;11371.658850234506;11511.136664750009;11668.533258669559;10447.68656940293;11195.2723073;11811.586594469496;11813.40932953366;11965.162438629213;8235.176482351957;8343.833123337377;8405.789855253668;8513.574321283788;8641.56792160402;8384.790380240544;11030.22788404804;11603.593874214363;11664.183507154758;11863.644090677293 07:27:54 INFO - PROCESS | 3399 | |3;mootools.html;1252.1547955130288;1282.1409655530806;1383.2668685596634;1405.873471387575;1872.0452569189708;7344.41244700424;8296.253337199658;8491.320694344453;8502.872456913135;8531.232189102988;7944.443888927763;8107.3919456040885;8110.716124935629;8118.878216826753;8147.388945829057;1909.2935613822906;2204.239537359608;2236.127910115052;2263.20787724296;2267.489814791675;2316.4324740438615;2333.9766602334016;2336.0188720737247;2339.777721116491;2340.1341503643675;2253.7070180876462;2293.1973809166825;2301.033565902325;2302.3553405046614;2303.320520446464;1872.8408085312697;2217.0688310909377;2279.5099053703534;2284.200529814568;2284.657301404786;2212.933611991643;2219.1899956515917;2227;2227.387468446174;2259.1189436119926;7966.681332746683;8003.239692229229;8024.117347091816;8033.2770050695135;8434.325253979667;4910.263460480921;5064.924026139611;5073.644844860862;5074.4925507449325;5076.796928122871;3135.325904930428;3180.7137357637926;3207.7273431758094;3233.822139782311;3262.624798148196;1085.1481586954283;1088.7223757941674;1093.294824837975;1100.2078503477483;1142.782871254459;11479;11513.194076414571;11520.078393728481;11594.710132246677;11606.129540284428;4382.583654552813;4423.579759922803;4535.9546404536195;4583.175028494903;4713.175194340976;9867.259955503367;9880.654177103766;9881.604735810488;9890.554925028391;9902.257330700226;4582.1293954148605;5161.922571161435;5198.844034678966;5205.063088644005;5226.477352264743;4464.575865292792;4520.751358675238;4536.500984891659;4571.062932098912;4572.359869618256;3885.8445662173763;3892.4355968384425;3985.262726395626;3986.664467403394;3998.8000599969887;1212.1878341511033;1220.9389530523438;1223.3088305107585;1240.0389697984135;1251.4931452761646;958;1011.231464087299;1026.7946410717886;1028.2647906746713;1032.1794173631981;5788.594798364158;5868.823935281948;5879.000569903127;5931.73307201177;6152.723127459275;443.37705523739197;455.90426010537493;466.0608873120665;469.01974872516604;469.8825293676581;3998.28030954431;4104;4121.113960498507;4123.670106391482;4184.916301673949;10133.949330253301;10472.319299245524;10576.735581610521;10630.202734794766;10652;10063.597456101674;10428.113610343054;10440.060394564374;10467.685969420929;10478.685639430829;7238.855222895618;7307.159676637255;7367.226441223702;7385.261473852679;7386.704531818775;5829.8251052468495;5988.700564971821;6008.188894499362;6052.818415447544;6077.6353418795015;9465.526723663652;9478.620855165716;9492.477913714813;9660.806783864424;9735.9026409735;9741.512924353896;9832.55753491109;10086.142677872464;10088.092071713581;10131.037551432602;6809.5233333666165;7211.963940180265;7432.108147022392;7520.435967302584;7522.699092036257;8032.718854840053;8042.235987581171;8120.878186827084;8123.837523249384;8175.1007389188335;7194.712211511481;7311.853762924606;7329.670164842488;7411.036565246483;7590.430717696085;7343.632818358954;7367.2264412235945;7406;7441.181470038183;7513.699452021858;6928;6941.965290173517;7009.12385951756;7016.894746578703;7017.122859642544;5103.336566246364;5118.129917914038;5118.923216151687;5337.172738225581;5362.865928351823;4936.2102063669645;4954.826581069645;5007.47421520735;5255.211718242142;5261.421243663118 07:27:54 INFO - PROCESS | 3399 | |4;prototype.html;321.3572854291416;335.9093044877882;336.339093680917;337.86654271562736;342.87485067950206;5527.723613819308;5640.097584386499;5657.264555607765;5662.5186859116975;5667.234923285355;5290.259363689087;5451.781928722856;5462.481064298895;5498.862528436791;5622.100463925773;4226.978865105671;4393.362962370455;4393.824247030115;4402.075564131536;4410.823567057314;4355.499117601469;4387.319965405367;4388.912221755563;4396.758178300192;4397.032652816391;4116.156187981472;4351.71713838601;4352.39066530686;4356.259435895905;4362.847300344489;4323.978380108111;4335.653147748172;4335.761533115678;4343.391925130484;4361.4112094867105;3833.463315135883;3837.4627552142724;3837.769733815952;3840.0783811885226;3842.1739326044753;5187.7406129693745;5358.142697168473;5383.407825139231;5440.564754819605;5457.181422786574;4958.933829226734;4976.253561965734;4976.651634385595;4983.476734942815;4993.076280888047;5750.482456578928;5761.127633519081;5784.739686714108;5832.912506312408;5874;4112.835486580533;4188.434561334242;4202.159568086395;4205.264078786231;4208.494980602317;6120.540959428061;6130.540209484262;6154;6180.999999999955;6182.1345011698395;4274.978625106854;4287.699861009762;4296.4414626098405;4298.118885628439;4299.376590394438;4163.562825903236;4351.671855557262;4353.69524133314;4363.149185908717;4393.231184542692;4974.104661161025;4993.625478089085;4999.02519008797;5004.374453193351;5011.972545628138;5863;5929.717058932342;5929.881402371929;5931.73307201177;5972.895014422345;1462.349254581701;1480.0897448069575;1513.402206128573;1522.7030729007959;1528.159512268248;990.1880458024351;1003.7052202658489;1007.2495990487134;1015.9644412445529;1019.6176433837311;5629.296337957755;5632.295963004624;5655.9253741788925;5671.914921276184;5686.317641883001;5999.910001349983;6039.822234664199;6044.697765111727;6063.787767428207;6065.696715164224;5577.2191893135;5613.550915926716;5658.698499345173;5685.232493613392;5693.715314234271;3216.4049650814673;3260.9836950815093;3274.6889045540634;3276.3774882772195;3279.8032118072992;6158.353372895782;6282.4974002079725;6293.559450838397;6297.527685423612;6307.653079080695;6140.416660417253;6149.108379285068;6172.753089876444;6174.753009879644;6212.285587157445;6222.906656400158;6229.875402492015;6246.968765156236;6252.187215661935;6256.718447669866;5858.970705146447;6011.338752737282;6068.362821903636;6073;6098.908516372169;5969.313528944053;5975.163477113295;5980.073088671263;5985.162077309267;5999.580029398075;6016.759329626766;6219.689015549295;6221.844453888689;6245.313015568375;6266.37336266388;3972.960270397259;4135.8966025849595;4229.133027729246;4270.081932384553;4292;6066.4530544710815;6075.574709770451;6081.087836824512;6084.117802918464;6085.726142323518;5906.143609176559;5911.497522710446;5917.556183286185;5935.465808077293;5940.257467816523;5690.3456102548735;5932.79235226765;5939.643621382731;6006.819795406145;6010.879782404415;5816.70916454184;5914.319853216935;5927.792527261525;5928.318243402064;5928.466438020599;5834.15404766315;5973.253343332083;5986.850328741816;6056.9697151513965;6069.3020302665755;5811.767529298781;5822.243108395882;5822.5633077518505;5880.882382352243;5894.528437725057 07:27:54 INFO - PROCESS | 3399 | |5;yui.html;633.436241744847;668.3083009085595;696.5194016128871;699.2378307644666;705.7071315404107;11826.704332391684;12864.099513034067;13030.934845325772;13230.801537976939;13351.465941362334;12410.441530131144;12473.875261247385;12506.937465312662;12556.93721531391;12564.183328083669;662.7050962321769;795.1015352651525;806.6450761664878;822.8313195794877;825.0511911301991;811.3022800391687;812.6708682983401;813.4753084260678;815.0871024452622;820.3806126374578;845.2772879188298;848.452747977554;848.7793173774801;850.2390360627235;856.6230858422306;687.1753895325604;828.8756686497013;853.7822855171953;854.9572521373907;857.7469646454311;624.8156793745856;624.893768059431;625.0436831647586;625.2778041362234;625.3340192694766;12498.562550310695;12505.812412813815;12507;12544.749105017849;12573.434195461226;12182.695432614168;12666.87333126666;13001.544945926942;13115.672108197276;13216.537421190309;10107.595696172144;10342.224333175041;10401.323913945569;10473.47632618366;10536.157107431387;3598.5681718193723;3619.4751760994773;3642.8360723767228;3656.469811877263;3682.061074426031;54238.186427203625;54246;54346;54724;54962.45037549653;10006.899931000742;10008.199344052458;10326.741831454123;10384;10622.309549879234;17536.29854805819;17687.823121768874;17688.9115554424;17691.823081769275;17715.822841771675;7656.885146722803;7752.186020467882;7815.218478152253;7839.176886426957;7986.201379861967;4251.73290779437;4282.207791558571;4290.056187638715;4356.411884395629;4474.507804141542;2967.3620171662765;3054.801437906529;3057.7400920921527;3059.586955760944;3060.602121724206;574.7815829984663;591.8106206014035;594.9345571987078;601.4677010845434;606.1120458528277;568.0853825341197;613.910982907476;624.9531285153631;691.512483698991;722.7398136670794;8359.247667709935;8614.310855131574;8748.258232794295;8777.561121943878;8899.822003559893;528.2683483375553;605.2494906316136;627.5199472403615;632.7310892870512;635.7012204264081;4022.35642297231;4224.155168966219;4263;4267.3432330920705;4356.259435895842;60363.698181508815;61123;61636.69181654063;61681;61773.38226617676;51199.74400127975;51810;52798.73600631972;52967.47032529702;54838.45161548413;42371;45785.542144578794;47053;47456.288155677;49479.25781113286;8491.8726219108;8505.659773608986;8792.164744349277;8807.647694092164;9045.728628141167;30955.845220774652;32139.839300803345;32682.673173267962;33048.50427243641;33271.50092748562;40626.796866016666;41482.37776433295;41859.7907010463;42391.15217695691;43886.34170487509;11046.085596023364;11089.168312376443;11515;11679.591214307458;11833.053355731348;12006.519739210335;12290.385480726107;12586.496540138292;12821.294828784134;12892.162009469355;11652.184347095961;11717.941410292893;11778.234414763014;12074.517019319128;12368.319742414255;12257.632271031884;12400.937995309965;12565.18326308787;12568.93715531453;12716.682082948;12069;12080.335581543099;12100.394980251129;12226.327551984727;12516.061295402698;10523.789524209626;10525.473726313807;10640.574377025141;10645.840312395165;10787.730306742395;10436.321639093434;10546.57813687444;10579.89420105789;10611.31026483276;10756.946215268874 07:27:54 INFO - PROCESS | 3399 | __end_tp_report 07:27:54 INFO - PROCESS | 3399 | __start_cc_report 07:27:54 INFO - PROCESS | 3399 | _x_x_mozilla_cycle_collect,1003 07:27:54 INFO - PROCESS | 3399 | __end_cc_report 07:27:54 INFO - PROCESS | 3399 | __startTimestamp1460989674662__endTimestamp 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | ------- Summary: start ------- 07:27:54 INFO - PROCESS | 3399 | Number of tests: 6 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | [#0] dojo.html Cycles:165 Average:5245.58 Median:5453.35 stddev:596.04 (10.9%) stddev-sans-first:572.13 07:27:54 INFO - PROCESS | 3399 | Values: 3036.8 3088.0 3128.3 3130.6 3157.1 5134.5 5255.7 5264.2 5295.1 5301.8 5268.4 5277.7 5280.8 5282.0 5323.7 4787.6 4799.7 4820.9 4841.1 4952.0 4809.2 4818.2 4822.9 4827.3 4828.0 4740.3 4766.6 4793.8 4848.3 4863.2 4740.6 4752.1 4773.5 4825.5 4895.7 4756.0 4766.0 4778.2 4789.1 4832.3 5128.3 5189.8 5193.6 5217.3 5249.5 5587.7 5611.3 5618.6 5658.0 5676.6 5688.9 5719.6 5740.9 5741.9 5744.9 5245.4 5270.0 5358.7 5361.1 5362.5 5709.5 5710.1 5714.1 5755.1 5758.3 5455.2 5459.7 5461.3 5492.8 5526.2 5517.0 5573.9 5577.8 5583.5 5587.1 5671.5 5696.2 5723.5 5725.3 5774.0 5555.5 5559.6 5571.3 5586.0 5601.7 4220.5 4263.4 4271.9 4289.7 4313.9 3813.1 3815.0 3844.8 3865.3 3879.1 5304.7 5327.9 5337.0 5346.7 5371.4 5453.3 5641.9 5670.8 5730.9 5840.4 5356.0 5367.1 5370.1 5388.4 5390.1 4740.1 4770.5 4772.5 4780.7 4823.6 5783.8 5826.4 5834.8 5928.0 5929.2 5668.9 5688.5 5693.6 5699.6 5717.4 5859.3 5863.0 5877.8 5881.2 5894.3 5377.9 5503.4 5554.5 5575.9 5613.0 5654.9 5669.8 5674.3 5684.7 5685.8 5434.2 5510.3 5519.8 5541.0 5545.7 5495.4 5533.1 5547.6 5559.3 5601.8 5444.0 5450.8 5484.7 5496.4 5500.4 5533.0 5595.1 5602.6 5614.6 5631.2 5284.8 5404.5 5443.6 5538.4 5543.3 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | [#1] ext.html Cycles:180 Average:57774.95 Median:37490.13 stddev:110661.35 (295.2%) stddev-sans-first:110888.49 07:27:54 INFO - PROCESS | 3399 | Values: 588.6 597.1 641.7 646.0 647.9 37809.0 38958.0 39029.0 39029.0 39043.8 40871.0 41647.4 41727.0 41762.6 41841.4 7115.5 8635.2 8866.4 9996.6 10296.9 10190.8 10389.4 10394.4 10411.3 10423.7 10427.5 10514.7 10517.5 10518.2 10526.6 7473.3 10088.0 10385.8 10402.7 10408.1 9883.1 9935.9 10011.3 10016.5 10027.6 38682.2 39290.2 39304.2 39384.4 39424.6 3152.3 3242.1 3321.7 3466.5 3503.8 32262.5 32448.8 32481.5 32679.0 33180.2 4351.8 4411.7 4417.8 4443.7 4447.3 300644.0 304101.0 304157.0 304235.0 304566.5 60986.4 61285.0 61695.4 61744.1 61825.0 64150.7 67133.7 69482.0 69656.3 69670.7 14648.6 15837.5 16136.0 16140.8 16153.6 10749.0 11060.3 11084.5 11086.9 11104.2 19547.4 20669.3 20760.9 20763.3 20813.7 7698.0 7793.6 7896.8 7972.3 8074.2 1090.2 1095.4 1111.6 1115.8 1175.2 31878.2 32079.7 32373.7 32619.7 33989.3 1092.8 1120.3 1146.4 1174.2 1189.6 16383.8 16506.9 16662.7 16684.4 16834.2 476158.0 480811.0 482902.0 484439.0 489545.0 55667.0 56599.0 56638.4 56673.7 56721.7 1215.4 1348.0 1355.5 1372.6 1434.1 27955.7 28727.9 28845.9 29488.7 29861.0 42498.0 45110.3 46539.0 46663.3 46714.0 442344.0 443936.0 447163.0 448925.0 452272.0 36850.4 42756.4 46744.3 47504.5 47659.6 44441.1 44725.0 44932.6 45289.3 45482.5 37494.6 37736.4 38321.0 38438.0 39102.0 37009.0 37485.6 38371.8 38397.4 38810.4 39589.4 39725.4 40118.4 41418.8 43410.1 33691.5 34650.3 34855.1 35054.6 35366.0 25715.6 26793.9 27265.2 27535.2 27583.7 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | [#2] jquery.html Cycles:180 Average:27658.75 Median:32838.34 stddev:78453.84 (238.9%) stddev-sans-first:78647.21 07:27:54 INFO - PROCESS | 3399 | Values: 392.3 396.3 402.6 404.3 406.4 13739.9 17586.3 17806.5 18541.1 18549.9 15251.5 15639.8 15937.8 16101.8 16154.0 5420.5 5527.1 5663.0 5703.9 5710.8 5590.0 5602.6 5626.9 5634.5 5649.6 5136.2 5460.6 5566.4 5607.3 5611.9 5237.8 5313.0 5396.5 5429.3 5431.4 5493.5 5495.6 5538.8 5554.6 5556.2 12892.0 13071.0 16397.7 21422.7 21489.5 2120.0 2150.8 2323.8 2357.6 2391.6 9542.3 10084.7 10154.9 10169.7 10353.6 1885.2 1945.1 1986.4 1988.0 2031.0 77769.0 79583.6 79983.0 81888.0 81934.6 10420.2 10529.2 10622.9 10701.3 10849.9 12863.5 13580.5 15192.8 15202.9 15317.3 5595.8 5692.5 6805.8 7164.6 7296.5 6760.7 6900.8 6920.9 7085.3 7135.0 4449.6 4469.4 4535.8 4593.2 4666.3 1765.0 1901.2 1949.4 1972.3 1992.5 914.6 976.3 1015.3 1037.4 1054.9 17759.3 17781.0 17914.6 17928.0 18181.5 932.2 943.6 956.3 993.1 1060.1 8245.4 9916.2 10065.5 10177.6 10265.6 463489.0 469944.0 475247.0 481083.0 484816.0 78160.2 92655.5 96526.0 97423.0 100954.1 1072.5 1078.9 1107.4 1112.7 1123.0 16483.0 16951.7 16980.2 17121.3 17276.0 29038.4 36638.3 38808.4 38911.4 40400.8 42450.4 51841.7 51968.2 53058.6 57928.4 8154.2 8239.8 8245.3 8393.5 8462.1 9342.9 12441.6 12704.6 12724.2 12740.4 11102.4 11708.2 11795.4 11869.1 11970.5 11028.6 11295.4 11371.7 11511.1 11668.5 10447.7 11195.3 11811.6 11813.4 11965.2 8235.2 8343.8 8405.8 8513.6 8641.6 8384.8 11030.2 11603.6 11664.2 11863.6 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | [#3] mootools.html Cycles:180 Average:5551.44 Median:469.45 stddev:3128.62 (666.4%) stddev-sans-first:3120.71 07:27:54 INFO - PROCESS | 3399 | Values: 1252.2 1282.1 1383.3 1405.9 1872.0 7344.4 8296.3 8491.3 8502.9 8531.2 7944.4 8107.4 8110.7 8118.9 8147.4 1909.3 2204.2 2236.1 2263.2 2267.5 2316.4 2334.0 2336.0 2339.8 2340.1 2253.7 2293.2 2301.0 2302.4 2303.3 1872.8 2217.1 2279.5 2284.2 2284.7 2212.9 2219.2 2227.0 2227.4 2259.1 7966.7 8003.2 8024.1 8033.3 8434.3 4910.3 5064.9 5073.6 5074.5 5076.8 3135.3 3180.7 3207.7 3233.8 3262.6 1085.1 1088.7 1093.3 1100.2 1142.8 11479.0 11513.2 11520.1 11594.7 11606.1 4382.6 4423.6 4536.0 4583.2 4713.2 9867.3 9880.7 9881.6 9890.6 9902.3 4582.1 5161.9 5198.8 5205.1 5226.5 4464.6 4520.8 4536.5 4571.1 4572.4 3885.8 3892.4 3985.3 3986.7 3998.8 1212.2 1220.9 1223.3 1240.0 1251.5 958.0 1011.2 1026.8 1028.3 1032.2 5788.6 5868.8 5879.0 5931.7 6152.7 443.4 455.9 466.1 469.0 469.9 3998.3 4104.0 4121.1 4123.7 4184.9 10133.9 10472.3 10576.7 10630.2 10652.0 10063.6 10428.1 10440.1 10467.7 10478.7 7238.9 7307.2 7367.2 7385.3 7386.7 5829.8 5988.7 6008.2 6052.8 6077.6 9465.5 9478.6 9492.5 9660.8 9735.9 9741.5 9832.6 10086.1 10088.1 10131.0 6809.5 7212.0 7432.1 7520.4 7522.7 8032.7 8042.2 8120.9 8123.8 8175.1 7194.7 7311.9 7329.7 7411.0 7590.4 7343.6 7367.2 7406.0 7441.2 7513.7 6928.0 6942.0 7009.1 7016.9 7017.1 5103.3 5118.1 5118.9 5337.2 5362.9 4936.2 4954.8 5007.5 5255.2 5261.4 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | [#4] prototype.html Cycles:180 Average:4958.58 Median:5656.59 stddev:1468.25 (26.0%) stddev-sans-first:1430.52 07:27:54 INFO - PROCESS | 3399 | Values: 321.4 335.9 336.3 337.9 342.9 5527.7 5640.1 5657.3 5662.5 5667.2 5290.3 5451.8 5462.5 5498.9 5622.1 4227.0 4393.4 4393.8 4402.1 4410.8 4355.5 4387.3 4388.9 4396.8 4397.0 4116.2 4351.7 4352.4 4356.3 4362.8 4324.0 4335.7 4335.8 4343.4 4361.4 3833.5 3837.5 3837.8 3840.1 3842.2 5187.7 5358.1 5383.4 5440.6 5457.2 4958.9 4976.3 4976.7 4983.5 4993.1 5750.5 5761.1 5784.7 5832.9 5874.0 4112.8 4188.4 4202.2 4205.3 4208.5 6120.5 6130.5 6154.0 6181.0 6182.1 4275.0 4287.7 4296.4 4298.1 4299.4 4163.6 4351.7 4353.7 4363.1 4393.2 4974.1 4993.6 4999.0 5004.4 5012.0 5863.0 5929.7 5929.9 5931.7 5972.9 1462.3 1480.1 1513.4 1522.7 1528.2 990.2 1003.7 1007.2 1016.0 1019.6 5629.3 5632.3 5655.9 5671.9 5686.3 5999.9 6039.8 6044.7 6063.8 6065.7 5577.2 5613.6 5658.7 5685.2 5693.7 3216.4 3261.0 3274.7 3276.4 3279.8 6158.4 6282.5 6293.6 6297.5 6307.7 6140.4 6149.1 6172.8 6174.8 6212.3 6222.9 6229.9 6247.0 6252.2 6256.7 5859.0 6011.3 6068.4 6073.0 6098.9 5969.3 5975.2 5980.1 5985.2 5999.6 6016.8 6219.7 6221.8 6245.3 6266.4 3973.0 4135.9 4229.1 4270.1 4292.0 6066.5 6075.6 6081.1 6084.1 6085.7 5906.1 5911.5 5917.6 5935.5 5940.3 5690.3 5932.8 5939.6 6006.8 6010.9 5816.7 5914.3 5927.8 5928.3 5928.5 5834.2 5973.3 5986.9 6057.0 6069.3 5811.8 5822.2 5822.6 5880.9 5894.5 07:27:54 INFO - PROCESS | 3399 | 07:27:54 INFO - PROCESS | 3399 | [#5] yui.html Cycles:180 Average:14086.72 Median:42381.08 stddev:16507.68 (39.0%) stddev-sans-first:16523.07 07:27:54 INFO - PROCESS | 3399 | Values: 633.4 668.3 696.5 699.2 705.7 11826.7 12864.1 13030.9 13230.8 13351.5 12410.4 12473.9 12506.9 12556.9 12564.2 662.7 795.1 806.6 822.8 825.1 811.3 812.7 813.5 815.1 820.4 845.3 848.5 848.8 850.2 856.6 687.2 828.9 853.8 855.0 857.7 624.8 624.9 625.0 625.3 625.3 12498.6 12505.8 12507.0 12544.7 12573.4 12182.7 12666.9 13001.5 13115.7 13216.5 10107.6 10342.2 10401.3 10473.5 10536.2 3598.6 3619.5 3642.8 3656.5 3682.1 54238.2 54246.0 54346.0 54724.0 54962.5 10006.9 10008.2 10326.7 10384.0 10622.3 17536.3 17687.8 17688.9 17691.8 17715.8 7656.9 7752.2 7815.2 7839.2 7986.2 4251.7 4282.2 4290.1 4356.4 4474.5 2967.4 3054.8 3057.7 3059.6 3060.6 574.8 591.8 594.9 601.5 606.1 568.1 613.9 625.0 691.5 722.7 8359.2 8614.3 8748.3 8777.6 8899.8 528.3 605.2 627.5 632.7 635.7 4022.4 4224.2 4263.0 4267.3 4356.3 60363.7 61123.0 61636.7 61681.0 61773.4 51199.7 51810.0 52798.7 52967.5 54838.5 42371.0 45785.5 47053.0 47456.3 49479.3 8491.9 8505.7 8792.2 8807.6 9045.7 30955.8 32139.8 32682.7 33048.5 33271.5 40626.8 41482.4 41859.8 42391.2 43886.3 11046.1 11089.2 11515.0 11679.6 11833.1 12006.5 12290.4 12586.5 12821.3 12892.2 11652.2 11717.9 11778.2 12074.5 12368.3 12257.6 12400.9 12565.2 12568.9 12716.7 12069.0 12080.3 12100.4 12226.3 12516.1 10523.8 10525.5 10640.6 10645.8 10787.7 10436.3 10546.6 10579.9 10611.3 10756.9 07:27:54 INFO - PROCESS | 3399 | -------- Summary: end -------- 07:27:54 INFO - PROCESS | 3399 | 07:27:55 INFO - TEST-INFO | 3399: exit 0 07:27:55 INFO - TEST-OK | dromaeo_css | took 1112750ms 07:27:55 INFO - TEST-START | kraken 07:27:55 INFO - operating with platform_type : linux_ 07:27:55 INFO - Initialising browser for kraken test... 07:27:55 INFO - TEST-INFO | started process 3584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcb2MvT/profile http://localhost:57398/getInfo.html) 07:27:59 INFO - PROCESS | 3584 | __metrics Screen width/height:1600/1200 07:27:59 INFO - PROCESS | 3584 | colorDepth:24 07:27:59 INFO - PROCESS | 3584 | Browser inner width/height: 1024/697 07:27:59 INFO - PROCESS | 3584 | __metrics 07:28:00 ERROR - PROCESS | 3584 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:28:00 INFO - TEST-INFO | 3584: exit 0 07:28:00 INFO - Browser initialized. 07:28:00 INFO - Running cycle 1/1 for kraken test... 07:28:00 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcb2MvT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:12 INFO - PROCESS | 3663 | RSS: Main: 153174016 07:28:12 INFO - PROCESS | 3663 | 07:28:15 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57398/tests/kraken/driver.html?testName=audio-beat-detection) 07:28:16 INFO - PROCESS | 3663 | RSS: Main: 207994880 07:28:16 INFO - PROCESS | 3663 | 07:28:18 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57398/tests/kraken/driver.html?testName=audio-dft) 07:28:19 INFO - PROCESS | 3663 | RSS: Main: 193318912 07:28:19 INFO - PROCESS | 3663 | 07:28:22 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57398/tests/kraken/driver.html?testName=audio-fft) 07:28:22 INFO - PROCESS | 3663 | RSS: Main: 266293248 07:28:22 INFO - PROCESS | 3663 | 07:28:25 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57398/tests/kraken/driver.html?testName=audio-oscillator) 07:28:25 INFO - PROCESS | 3663 | RSS: Main: 173404160 07:28:25 INFO - PROCESS | 3663 | 07:28:27 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57398/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:28:28 INFO - PROCESS | 3663 | RSS: Main: 177352704 07:28:28 INFO - PROCESS | 3663 | 07:28:31 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57398/tests/kraken/driver.html?testName=imaging-darkroom) 07:28:32 INFO - PROCESS | 3663 | RSS: Main: 214011904 07:28:32 INFO - PROCESS | 3663 | 07:28:35 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57398/tests/kraken/driver.html?testName=imaging-desaturate) 07:28:35 INFO - PROCESS | 3663 | RSS: Main: 214077440 07:28:35 INFO - PROCESS | 3663 | 07:28:38 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57398/tests/kraken/driver.html?testName=json-parse-financial) 07:28:39 INFO - PROCESS | 3663 | RSS: Main: 214077440 07:28:39 INFO - PROCESS | 3663 | 07:28:40 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57398/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:28:41 INFO - PROCESS | 3663 | RSS: Main: 201109504 07:28:41 INFO - PROCESS | 3663 | 07:28:43 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:28:43 INFO - PROCESS | 3663 | RSS: Main: 204427264 07:28:43 INFO - PROCESS | 3663 | 07:28:46 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:28:47 INFO - PROCESS | 3663 | RSS: Main: 216264704 07:28:47 INFO - PROCESS | 3663 | 07:28:49 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:28:50 INFO - PROCESS | 3663 | RSS: Main: 223232000 07:28:50 INFO - PROCESS | 3663 | 07:28:52 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:28:53 INFO - PROCESS | 3663 | RSS: Main: 217874432 07:28:53 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:57398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57398/tests/kraken/driver.html?testName=ai-astar) 07:28:55 INFO - PROCESS | 3663 | RSS: Main: 281137152 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | __start_tp_report 07:28:55 INFO - PROCESS | 3663 | _x_x_mozilla_page_load 07:28:55 INFO - PROCESS | 3663 | _x_x_mozilla_page_load_details 07:28:55 INFO - PROCESS | 3663 | |i|pagename|runs| 07:28:55 INFO - PROCESS | 3663 | |0;ai-astar;107;110;104;109;109;118;99;109;108;109 07:28:55 INFO - PROCESS | 3663 | |1;audio-beat-detection;150;125;155;182;129;154;154;128;179;134 07:28:55 INFO - PROCESS | 3663 | |2;audio-dft;161;161;161;159;160;160;162;160;163;162 07:28:55 INFO - PROCESS | 3663 | |3;audio-fft;72;76;95;110;75;76;72;120;100;77 07:28:55 INFO - PROCESS | 3663 | |4;audio-oscillator;92;93;157;93;93;92;149;92;93;143 07:28:55 INFO - PROCESS | 3663 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 07:28:55 INFO - PROCESS | 3663 | |6;imaging-darkroom;145;145;145;145;145;145;145;146;146;146 07:28:55 INFO - PROCESS | 3663 | |7;imaging-desaturate;95;94;95;95;94;94;95;95;95;96 07:28:55 INFO - PROCESS | 3663 | |8;json-parse-financial;57;57;57;56;57;59;60;77;56;56 07:28:55 INFO - PROCESS | 3663 | |9;json-stringify-tinderbox;60;61;60;61;61;61;61;60;60;61 07:28:55 INFO - PROCESS | 3663 | |10;stanford-crypto-aes;76;76;77;74;75;75;75;76;78;76 07:28:55 INFO - PROCESS | 3663 | |11;stanford-crypto-ccm;122;124;129;131;125;122;121;125;167;131 07:28:55 INFO - PROCESS | 3663 | |12;stanford-crypto-pbkdf2;162;163;162;163;166;161;162;167;165;161 07:28:55 INFO - PROCESS | 3663 | |13;stanford-crypto-sha256-iterative;69;68;69;69;68;66;66;65;68;68 07:28:55 INFO - PROCESS | 3663 | __end_tp_report 07:28:55 INFO - PROCESS | 3663 | __start_cc_report 07:28:55 INFO - PROCESS | 3663 | _x_x_mozilla_cycle_collect,1616 07:28:55 INFO - PROCESS | 3663 | __end_cc_report 07:28:55 INFO - PROCESS | 3663 | __startTimestamp1460989735494__endTimestamp 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | ------- Summary: start ------- 07:28:55 INFO - PROCESS | 3663 | Number of tests: 14 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:4.78 (4.4%) stddev-sans-first:5.05 07:28:55 INFO - PROCESS | 3663 | Values: 107.0 110.0 104.0 109.0 109.0 118.0 99.0 109.0 108.0 109.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.00 stddev:20.33 (13.2%) stddev-sans-first:21.55 07:28:55 INFO - PROCESS | 3663 | Values: 150.0 125.0 155.0 182.0 129.0 154.0 154.0 128.0 179.0 134.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 07:28:55 INFO - PROCESS | 3663 | Values: 161.0 161.0 161.0 159.0 160.0 160.0 162.0 160.0 163.0 162.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.50 stddev:17.59 (23.3%) stddev-sans-first:17.77 07:28:55 INFO - PROCESS | 3663 | Values: 72.0 76.0 95.0 110.0 75.0 76.0 72.0 120.0 100.0 77.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.50 stddev:27.78 (30.0%) stddev-sans-first:28.72 07:28:55 INFO - PROCESS | 3663 | Values: 92.0 93.0 157.0 93.0 93.0 92.0 149.0 92.0 93.0 143.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:28:55 INFO - PROCESS | 3663 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:28:55 INFO - PROCESS | 3663 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:28:55 INFO - PROCESS | 3663 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 96.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:57.00 stddev:6.39 (11.2%) stddev-sans-first:6.73 07:28:55 INFO - PROCESS | 3663 | Values: 57.0 57.0 57.0 56.0 57.0 59.0 60.0 77.0 56.0 56.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:28:55 INFO - PROCESS | 3663 | Values: 60.0 61.0 60.0 61.0 61.0 61.0 61.0 60.0 60.0 61.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:1.14 (1.5%) stddev-sans-first:1.20 07:28:55 INFO - PROCESS | 3663 | Values: 76.0 76.0 77.0 74.0 75.0 75.0 75.0 76.0 78.0 76.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:127.00 stddev:13.61 (10.7%) stddev-sans-first:14.14 07:28:55 INFO - PROCESS | 3663 | Values: 122.0 124.0 129.0 131.0 125.0 122.0 121.0 125.0 167.0 131.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.00 stddev:2.10 (1.3%) stddev-sans-first:2.18 07:28:55 INFO - PROCESS | 3663 | Values: 162.0 163.0 162.0 163.0 166.0 161.0 162.0 167.0 165.0 161.0 07:28:55 INFO - PROCESS | 3663 | 07:28:55 INFO - PROCESS | 3663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.42 07:28:55 INFO - PROCESS | 3663 | Values: 69.0 68.0 69.0 69.0 68.0 66.0 66.0 65.0 68.0 68.0 07:28:55 INFO - PROCESS | 3663 | -------- Summary: end -------- 07:28:55 INFO - PROCESS | 3663 | 07:28:56 INFO - TEST-INFO | 3663: exit 0 07:28:56 INFO - TEST-OK | kraken | took 61111ms 07:28:56 INFO - SUITE-END | took 1173s 07:28:56 INFO - Completed test suite (00:19:34) 07:28:56 INFO - javascript benchmark 07:28:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.83297418642, 3087.9536806947913, 3128.3430479599283, 3130.5617213590085, 3157.084445510802, 5134.486551344864, 5255.658382205159, 5264.157734762439, 5295.099833028385, 5301.840944771653, 5268.446813084628, 5277.656952298098, 5280.815171468999, 5282.022825777224, 5323.653962492445, 4787.640926930477, 4799.688020278688, 4820.879478013043, 4841.128596852565, 4952.03435330109, 4809.158397280479, 4818.204996175627, 4822.855314340575, 4827.275908613701, 4828.0, 4740.336352910595, 4766.594839438651, 4793.832215872428, 4848.321235027064, 4863.197572400567, 4740.597049250818, 4752.144613969484, 4773.546513081252, 4825.541573550507, 4895.657303988723, 4755.952440475586, 4766.022965292107, 4778.187708089633, 4789.137955168068, 4832.251001094836, 5128.333316668846, 5189.844304670866, 5193.63644544882, 5217.34783152106, 5249.527542521153, 5587.7485513152005, 5611.270534830487, 5618.634788738719, 5658.0, 5676.574256930706, 5688.857778555528, 5719.571032172604, 5740.913886291709, 5741.856453588652, 5744.856378590527, 5245.370555533323, 5270.0, 5358.678479291255, 5361.142217245261, 5362.4637536246455, 5709.51469125129, 5710.086386178192, 5714.085746280575, 5755.136729490526, 5758.309002919593, 5455.236266922634, 5459.672419654833, 5461.2627295315415, 5492.80775172867, 5526.226328314039, 5517.0, 5573.860653483695, 5577.8047768327915, 5583.497485226268, 5587.1339942309005, 5671.489565939003, 5696.174054762119, 5723.456271654186, 5725.255716756878, 5774.018416869142, 5555.527780138734, 5559.583031272671, 5571.303587051619, 5585.972070139624, 5601.747921343549, 4220.493540775126, 4263.360495925574, 4271.850485233002, 4289.721168124062, 4313.9137217255475, 3813.122981714221, 3814.9809250953567, 3844.750091244116, 3865.323568375523, 3879.0884142226555, 5304.708241046779, 5327.946720532823, 5336.973315133399, 5346.705931173823, 5371.409144994048, 5453.345598528202, 5641.943580564224, 5670.829875103754, 5730.885382292414, 5840.415958404211, 5355.973220133952, 5367.060764366221, 5370.140777475585, 5388.434214407431, 5390.05674007055, 4740.1230772307235, 4770.451398089194, 4772.5227477252, 4780.665353425227, 4823.614110871122, 5783.797567085132, 5826.446487583673, 5834.824955251349, 5927.970360148258, 5929.169916211734, 5668.943310566924, 5688.459596338341, 5693.572982026281, 5699.572532060195, 5717.371089180104, 5859.296884373732, 5863.032599621015, 5877.823665290048, 5881.235439392852, 5894.322152952293, 5377.8924421510565, 5503.422140675331, 5554.50009499147, 5575.944240557543, 5612.971935140298, 5654.886902262014, 5669.801556945487, 5674.319081710221, 5684.744186511534, 5685.829425117253, 5434.212039254365, 5510.256115424367, 5519.779208831763, 5541.030319694118, 5545.722713864371, 5495.422980586981, 5533.059379905506, 5547.556195504269, 5559.305086864142, 5601.775928962796, 5444.0, 5450.754716037709, 5484.725763711878, 5496.367917689357, 5500.367457742251, 5533.0, 5595.076812326083, 5602.607817452739, 5614.606977511535, 5631.222620469965, 5284.762185701576, 5404.513593776579, 5443.618946673695, 5538.363088244742, 5543.279373681396], "value": 5205.6378694040395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5644622978995, 597.1371368372701, 641.7048157847391, 645.9838504037399, 647.9384458476443, 37809.0, 38958.0, 39029.0, 39029.0, 39043.80478097613, 40871.0, 41647.375289370684, 41727.0, 41762.58237417625, 41841.37237941433, 7115.501914865961, 8635.179657932485, 8866.379353445262, 9996.550155242996, 10296.897031029668, 10190.847137292909, 10389.376637401741, 10394.37633741974, 10411.271211015232, 10423.68728938133, 10427.478626068703, 10514.737131571695, 10517.474126293693, 10518.21113416493, 10526.631567895125, 7473.290037446461, 10088.0, 10385.792284154275, 10402.739931501697, 10408.115310198642, 9883.11052005323, 9935.90064099357, 10011.349262297927, 10016.499175041292, 10027.649032283907, 38682.226355473016, 39290.214195715926, 39304.21391572181, 39384.409233861516, 39424.60575394238, 3152.322250716084, 3242.1408326793417, 3321.667833216659, 3466.532018177539, 3503.7722548034553, 32262.516062259085, 32448.837755811306, 32481.51277730836, 32679.0, 33180.170495737555, 4351.804168812411, 4411.691181617288, 4417.8288814316675, 4443.688941774077, 4447.288433850601, 300644.0, 304100.9999999978, 304157.0, 304235.0, 304566.47716761497, 60986.39013609896, 61285.0, 61695.383046168965, 61744.07383889245, 61825.0, 64150.67924660347, 67133.664331679, 69482.0, 69656.30343696498, 69670.65164674245, 14648.560543183721, 15837.524874253791, 16136.0, 16140.75788863168, 16153.596160095856, 10748.97884700952, 11060.336379817236, 11084.501197446134, 11086.944565277123, 11104.167187460973, 19547.413577592695, 20669.276575319793, 20760.885867119752, 20763.273285434938, 20813.687794683094, 7697.961510192413, 7793.64928578204, 7896.763097107096, 7972.322352599978, 8074.192580741878, 1090.1660229924114, 1095.39205740813, 1111.6387174168428, 1115.8493603363443, 1175.2008634128874, 31878.203044924063, 32079.67920320767, 32373.676263237536, 32619.67380326214, 33989.32021359559, 1092.808758467265, 1120.3389999899935, 1146.415328182633, 1174.1898090317654, 1189.6371606660052, 16383.83616163847, 16506.917465412596, 16662.666746665, 16684.416045438353, 16834.24245908937, 476158.0, 480811.0, 482902.0, 484439.0, 489545.0, 55667.0, 56599.0, 56638.43361566414, 56673.71663141658, 56721.7163914186, 1215.392303848076, 1347.9730405391838, 1355.491690616019, 1372.6431127906817, 1434.0965191929017, 27955.720442796126, 28727.856360718062, 28845.855770721013, 29488.705112949454, 29861.0, 42498.0, 45110.32334514919, 46539.0, 46663.30005049859, 46714.0, 442344.0, 443936.0, 447163.0, 448925.0, 452272.0, 36850.44724329084, 42756.35865461958, 46744.29883551681, 47504.52495475001, 47659.57021289367, 44441.11117777691, 44725.0, 44932.550674492835, 45289.32066018946, 45482.54517454783, 37494.625053749114, 37736.433953491265, 38321.04197395087, 38438.0, 39102.0, 37009.0, 37485.625143749305, 38371.80814095912, 38397.424038638885, 38810.41784373293, 39589.40615890706, 39725.404118938815, 40118.398224027245, 41418.792906035276, 43410.131797364505, 33691.494627581094, 34650.30699385948, 34855.12862178466, 35054.64945350514, 35366.0, 25715.614265785654, 26793.86603066972, 27265.182044538695, 27535.173944781687, 27583.66717260926], "value": 20248.51894817041, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2605887901306, 396.26492855752593, 402.5752830763543, 404.2783631218276, 406.35998302673295, 13739.931300343509, 17586.296548138092, 17806.465806025808, 18541.07294635268, 18549.907250463762, 15251.542453726379, 15639.843601563982, 15937.760933586005, 16101.83898161018, 16154.0, 5420.512153906147, 5527.060399732055, 5663.037283661767, 5703.914441283384, 5710.77156913723, 5589.972050139764, 5602.635828671144, 5626.859328516799, 5634.464725851058, 5649.604527683064, 5136.203888397305, 5460.590455715837, 5566.415526369734, 5607.299087614048, 5611.8877622447735, 5237.816676416345, 5313.017091837984, 5396.541293990015, 5429.294191755086, 5431.429699881534, 5493.478119578634, 5495.587830912697, 5538.806141785059, 5554.611177217596, 5556.222128901957, 12892.0, 13071.0, 16397.67204655912, 21422.678659820114, 21489.46276343104, 2120.0353839003214, 2150.7741687122784, 2323.8257130715265, 2357.599029106893, 2391.629297458897, 9542.33203675743, 10084.69745907624, 10154.949225253826, 10169.694909152737, 10353.585856565729, 1885.1516817432073, 1945.1160240273146, 1986.414007867668, 1987.9503012424661, 2031.0048076442438, 77769.0, 79583.6020819898, 79983.0, 81888.0, 81934.59032704799, 10420.218483613608, 10529.210309226839, 10622.946885265525, 10701.304415212986, 10849.945750271356, 12863.485460581473, 13580.524681636096, 15192.784577233795, 15202.923985380003, 15317.31072101758, 5595.832125036255, 5692.516136128393, 6805.829854253683, 7164.641767911584, 7296.489245752747, 6760.661966901635, 6900.7929762107215, 6920.9307906920285, 7085.326893945067, 7135.036770035978, 4449.644028477714, 4469.4189755332245, 4535.80225940711, 4593.19619066662, 4666.346711460398, 1764.9647007059787, 1901.2490066423961, 1949.3859434278156, 1972.3491247888162, 1992.5118346005322, 914.6204325204966, 976.272676855747, 1015.3399192320609, 1037.4138611684375, 1054.8892366301582, 17759.289628414976, 17781.0, 17914.641707166043, 17928.0, 18181.54546136357, 932.1983094538691, 943.556528431636, 956.2636769687302, 993.056596233581, 1060.0512541275516, 8245.381596380295, 9916.157126644315, 10065.496725163712, 10177.592896284214, 10265.589376425009, 463489.0, 469944.0, 475247.0, 481083.0, 484816.0, 78160.21839781642, 92655.53672231731, 96526.0, 97423.0, 100954.07696287123, 1072.5227273863056, 1078.8975047370486, 1107.4241394474989, 1112.6940091474746, 1122.9909224070154, 16483.0, 16951.745723813907, 16980.150992450082, 17121.315147393965, 17276.049817260173, 29038.419231615673, 36638.267234655694, 38808.41787373135, 38911.41632875566, 40400.79799600983, 42450.36324455074, 51841.7407912958, 51968.220476693634, 53058.63296404302, 57928.4207157923, 8154.2253485918745, 8239.752807415787, 8245.299149572353, 8393.496390216362, 8462.069172391155, 9342.859857102014, 12441.626751197478, 12704.555340563036, 12724.1729287596, 12740.362981850685, 11102.444877756241, 11708.243763435212, 11795.410229488663, 11869.109816763605, 11970.521179152736, 11028.558857645925, 11295.37875416827, 11371.658850234506, 11511.136664750009, 11668.533258669559, 10447.68656940293, 11195.2723073, 11811.586594469496, 11813.40932953366, 11965.162438629213, 8235.176482351957, 8343.833123337377, 8405.789855253668, 8513.574321283788, 8641.56792160402, 8384.790380240544, 11030.22788404804, 11603.593874214363, 11664.183507154758, 11863.644090677293], "value": 8736.138836977656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.1547955130288, 1282.1409655530806, 1383.2668685596634, 1405.873471387575, 1872.0452569189708, 7344.41244700424, 8296.253337199658, 8491.320694344453, 8502.872456913135, 8531.232189102988, 7944.443888927763, 8107.3919456040885, 8110.716124935629, 8118.878216826753, 8147.388945829057, 1909.2935613822906, 2204.239537359608, 2236.127910115052, 2263.20787724296, 2267.489814791675, 2316.4324740438615, 2333.9766602334016, 2336.0188720737247, 2339.777721116491, 2340.1341503643675, 2253.7070180876462, 2293.1973809166825, 2301.033565902325, 2302.3553405046614, 2303.320520446464, 1872.8408085312697, 2217.0688310909377, 2279.5099053703534, 2284.200529814568, 2284.657301404786, 2212.933611991643, 2219.1899956515917, 2227.0, 2227.387468446174, 2259.1189436119926, 7966.681332746683, 8003.239692229229, 8024.117347091816, 8033.2770050695135, 8434.325253979667, 4910.263460480921, 5064.924026139611, 5073.644844860862, 5074.4925507449325, 5076.796928122871, 3135.325904930428, 3180.7137357637926, 3207.7273431758094, 3233.822139782311, 3262.624798148196, 1085.1481586954283, 1088.7223757941674, 1093.294824837975, 1100.2078503477483, 1142.782871254459, 11479.0, 11513.194076414571, 11520.078393728481, 11594.710132246677, 11606.129540284428, 4382.583654552813, 4423.579759922803, 4535.9546404536195, 4583.175028494903, 4713.175194340976, 9867.259955503367, 9880.654177103766, 9881.604735810488, 9890.554925028391, 9902.257330700226, 4582.1293954148605, 5161.922571161435, 5198.844034678966, 5205.063088644005, 5226.477352264743, 4464.575865292792, 4520.751358675238, 4536.500984891659, 4571.062932098912, 4572.359869618256, 3885.8445662173763, 3892.4355968384425, 3985.262726395626, 3986.664467403394, 3998.8000599969887, 1212.1878341511033, 1220.9389530523438, 1223.3088305107585, 1240.0389697984135, 1251.4931452761646, 958.0, 1011.231464087299, 1026.7946410717886, 1028.2647906746713, 1032.1794173631981, 5788.594798364158, 5868.823935281948, 5879.000569903127, 5931.73307201177, 6152.723127459275, 443.37705523739197, 455.90426010537493, 466.0608873120665, 469.01974872516604, 469.8825293676581, 3998.28030954431, 4104.0, 4121.113960498507, 4123.670106391482, 4184.916301673949, 10133.949330253301, 10472.319299245524, 10576.735581610521, 10630.202734794766, 10652.0, 10063.597456101674, 10428.113610343054, 10440.060394564374, 10467.685969420929, 10478.685639430829, 7238.855222895618, 7307.159676637255, 7367.226441223702, 7385.261473852679, 7386.704531818775, 5829.8251052468495, 5988.700564971821, 6008.188894499362, 6052.818415447544, 6077.6353418795015, 9465.526723663652, 9478.620855165716, 9492.477913714813, 9660.806783864424, 9735.9026409735, 9741.512924353896, 9832.55753491109, 10086.142677872464, 10088.092071713581, 10131.037551432602, 6809.5233333666165, 7211.963940180265, 7432.108147022392, 7520.435967302584, 7522.699092036257, 8032.718854840053, 8042.235987581171, 8120.878186827084, 8123.837523249384, 8175.1007389188335, 7194.712211511481, 7311.853762924606, 7329.670164842488, 7411.036565246483, 7590.430717696085, 7343.632818358954, 7367.2264412235945, 7406.0, 7441.181470038183, 7513.699452021858, 6928.0, 6941.965290173517, 7009.12385951756, 7016.894746578703, 7017.122859642544, 5103.336566246364, 5118.129917914038, 5118.923216151687, 5337.172738225581, 5362.865928351823, 4936.2102063669645, 4954.826581069645, 5007.47421520735, 5255.211718242142, 5261.421243663118], "value": 4395.008057641528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.3572854291416, 335.9093044877882, 336.339093680917, 337.86654271562736, 342.87485067950206, 5527.723613819308, 5640.097584386499, 5657.264555607765, 5662.5186859116975, 5667.234923285355, 5290.259363689087, 5451.781928722856, 5462.481064298895, 5498.862528436791, 5622.100463925773, 4226.978865105671, 4393.362962370455, 4393.824247030115, 4402.075564131536, 4410.823567057314, 4355.499117601469, 4387.319965405367, 4388.912221755563, 4396.758178300192, 4397.032652816391, 4116.156187981472, 4351.71713838601, 4352.39066530686, 4356.259435895905, 4362.847300344489, 4323.978380108111, 4335.653147748172, 4335.761533115678, 4343.391925130484, 4361.4112094867105, 3833.463315135883, 3837.4627552142724, 3837.769733815952, 3840.0783811885226, 3842.1739326044753, 5187.7406129693745, 5358.142697168473, 5383.407825139231, 5440.564754819605, 5457.181422786574, 4958.933829226734, 4976.253561965734, 4976.651634385595, 4983.476734942815, 4993.076280888047, 5750.482456578928, 5761.127633519081, 5784.739686714108, 5832.912506312408, 5874.0, 4112.835486580533, 4188.434561334242, 4202.159568086395, 4205.264078786231, 4208.494980602317, 6120.540959428061, 6130.540209484262, 6154.0, 6180.999999999955, 6182.1345011698395, 4274.978625106854, 4287.699861009762, 4296.4414626098405, 4298.118885628439, 4299.376590394438, 4163.562825903236, 4351.671855557262, 4353.69524133314, 4363.149185908717, 4393.231184542692, 4974.104661161025, 4993.625478089085, 4999.02519008797, 5004.374453193351, 5011.972545628138, 5863.0, 5929.717058932342, 5929.881402371929, 5931.73307201177, 5972.895014422345, 1462.349254581701, 1480.0897448069575, 1513.402206128573, 1522.7030729007959, 1528.159512268248, 990.1880458024351, 1003.7052202658489, 1007.2495990487134, 1015.9644412445529, 1019.6176433837311, 5629.296337957755, 5632.295963004624, 5655.9253741788925, 5671.914921276184, 5686.317641883001, 5999.910001349983, 6039.822234664199, 6044.697765111727, 6063.787767428207, 6065.696715164224, 5577.2191893135, 5613.550915926716, 5658.698499345173, 5685.232493613392, 5693.715314234271, 3216.4049650814673, 3260.9836950815093, 3274.6889045540634, 3276.3774882772195, 3279.8032118072992, 6158.353372895782, 6282.4974002079725, 6293.559450838397, 6297.527685423612, 6307.653079080695, 6140.416660417253, 6149.108379285068, 6172.753089876444, 6174.753009879644, 6212.285587157445, 6222.906656400158, 6229.875402492015, 6246.968765156236, 6252.187215661935, 6256.718447669866, 5858.970705146447, 6011.338752737282, 6068.362821903636, 6073.0, 6098.908516372169, 5969.313528944053, 5975.163477113295, 5980.073088671263, 5985.162077309267, 5999.580029398075, 6016.759329626766, 6219.689015549295, 6221.844453888689, 6245.313015568375, 6266.37336266388, 3972.960270397259, 4135.8966025849595, 4229.133027729246, 4270.081932384553, 4292.0, 6066.4530544710815, 6075.574709770451, 6081.087836824512, 6084.117802918464, 6085.726142323518, 5906.143609176559, 5911.497522710446, 5917.556183286185, 5935.465808077293, 5940.257467816523, 5690.3456102548735, 5932.79235226765, 5939.643621382731, 6006.819795406145, 6010.879782404415, 5816.70916454184, 5914.319853216935, 5927.792527261525, 5928.318243402064, 5928.466438020599, 5834.15404766315, 5973.253343332083, 5986.850328741816, 6056.9697151513965, 6069.3020302665755, 5811.767529298781, 5822.243108395882, 5822.5633077518505, 5880.882382352243, 5894.528437725057], "value": 4486.08258282277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.436241744847, 668.3083009085595, 696.5194016128871, 699.2378307644666, 705.7071315404107, 11826.704332391684, 12864.099513034067, 13030.934845325772, 13230.801537976939, 13351.465941362334, 12410.441530131144, 12473.875261247385, 12506.937465312662, 12556.93721531391, 12564.183328083669, 662.7050962321769, 795.1015352651525, 806.6450761664878, 822.8313195794877, 825.0511911301991, 811.3022800391687, 812.6708682983401, 813.4753084260678, 815.0871024452622, 820.3806126374578, 845.2772879188298, 848.452747977554, 848.7793173774801, 850.2390360627235, 856.6230858422306, 687.1753895325604, 828.8756686497013, 853.7822855171953, 854.9572521373907, 857.7469646454311, 624.8156793745856, 624.893768059431, 625.0436831647586, 625.2778041362234, 625.3340192694766, 12498.562550310695, 12505.812412813815, 12507.0, 12544.749105017849, 12573.434195461226, 12182.695432614168, 12666.87333126666, 13001.544945926942, 13115.672108197276, 13216.537421190309, 10107.595696172144, 10342.224333175041, 10401.323913945569, 10473.47632618366, 10536.157107431387, 3598.5681718193723, 3619.4751760994773, 3642.8360723767228, 3656.469811877263, 3682.061074426031, 54238.186427203625, 54246.0, 54346.0, 54724.0, 54962.45037549653, 10006.899931000742, 10008.199344052458, 10326.741831454123, 10384.0, 10622.309549879234, 17536.29854805819, 17687.823121768874, 17688.9115554424, 17691.823081769275, 17715.822841771675, 7656.885146722803, 7752.186020467882, 7815.218478152253, 7839.176886426957, 7986.201379861967, 4251.73290779437, 4282.207791558571, 4290.056187638715, 4356.411884395629, 4474.507804141542, 2967.3620171662765, 3054.801437906529, 3057.7400920921527, 3059.586955760944, 3060.602121724206, 574.7815829984663, 591.8106206014035, 594.9345571987078, 601.4677010845434, 606.1120458528277, 568.0853825341197, 613.910982907476, 624.9531285153631, 691.512483698991, 722.7398136670794, 8359.247667709935, 8614.310855131574, 8748.258232794295, 8777.561121943878, 8899.822003559893, 528.2683483375553, 605.2494906316136, 627.5199472403615, 632.7310892870512, 635.7012204264081, 4022.35642297231, 4224.155168966219, 4263.0, 4267.3432330920705, 4356.259435895842, 60363.698181508815, 61123.0, 61636.69181654063, 61681.0, 61773.38226617676, 51199.74400127975, 51810.0, 52798.73600631972, 52967.47032529702, 54838.45161548413, 42371.0, 45785.542144578794, 47053.0, 47456.288155677, 49479.25781113286, 8491.8726219108, 8505.659773608986, 8792.164744349277, 8807.647694092164, 9045.728628141167, 30955.845220774652, 32139.839300803345, 32682.673173267962, 33048.50427243641, 33271.50092748562, 40626.796866016666, 41482.37776433295, 41859.7907010463, 42391.15217695691, 43886.34170487509, 11046.085596023364, 11089.168312376443, 11515.0, 11679.591214307458, 11833.053355731348, 12006.519739210335, 12290.385480726107, 12586.496540138292, 12821.294828784134, 12892.162009469355, 11652.184347095961, 11717.941410292893, 11778.234414763014, 12074.517019319128, 12368.319742414255, 12257.632271031884, 12400.937995309965, 12565.18326308787, 12568.93715531453, 12716.682082948, 12069.0, 12080.335581543099, 12100.394980251129, 12226.327551984727, 12516.061295402698, 10523.789524209626, 10525.473726313807, 10640.574377025141, 10645.840312395165, 10787.730306742395, 10436.321639093434, 10546.57813687444, 10579.89420105789, 10611.31026483276, 10756.946215268874], "value": 6359.524553660966, "unit": "score"}], "name": "dromaeo_css", "value": 6978.261422350296, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 104.0, 109.0, 109.0, 118.0, 99.0, 109.0, 108.0, 109.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 155.0, 182.0, 129.0, 154.0, 154.0, 128.0, 179.0, 134.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 159.0, 160.0, 160.0, 162.0, 160.0, 163.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 95.0, 110.0, 75.0, 76.0, 72.0, 120.0, 100.0, 77.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 157.0, 93.0, 93.0, 92.0, 149.0, 92.0, 93.0, 143.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 96.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 59.0, 60.0, 77.0, 56.0, 56.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 74.0, 75.0, 75.0, 75.0, 76.0, 78.0, 76.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 129.0, 131.0, 125.0, 122.0, 121.0, 125.0, 167.0, 131.0], "value": 129.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 166.0, 161.0, 162.0, 167.0, 165.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 69.0, 68.0, 66.0, 66.0, 65.0, 68.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1528.1999999999998, "alertThreshold": 2.0}]} 07:28:56 INFO - Return code: 0 07:28:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:28:56 ERROR - # TBPL SUCCESS # 07:28:56 INFO - Running post-action listener: _resource_record_post_action 07:28:56 INFO - Running post-run listener: _resource_record_post_run 07:28:57 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8081408; Write bytes: 430501888; Read time: 1296; Write time: 317848 07:28:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108072960; Read time: 0; Write time: 74940 07:28:57 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6193152; Write bytes: 322428928; Read time: 1128; Write time: 242908 07:28:57 INFO - Running post-run listener: _upload_blobber_files 07:28:57 INFO - Blob upload gear active. 07:28:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:28:57 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 07:28:57 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:28:57 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:28:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:59 INFO - (blobuploader) - INFO - Done attempting. 07:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:59 INFO - (blobuploader) - INFO - Done attempting. 07:28:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:59 INFO - Return code: 0 07:28:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:28:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d0625030c46b6f188bbe6b5ca7e69d52d7c3b2ec44908da77e96ea60150e0a8bbc326f5de93c06cc0c90f41f8f0f41e72389cdde561af81178bf4f89bc4b7ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a782ed1fedfd0f38896eaf127f115a88221f9a55fd97eeb89e1f37c4e2a2f529e9a34f4191b1f40ed8281b2ca9975f43261ebda8bd54d1e5f50e80529cf215bb"} 07:28:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:28:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:28:59 INFO - Contents: 07:28:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d0625030c46b6f188bbe6b5ca7e69d52d7c3b2ec44908da77e96ea60150e0a8bbc326f5de93c06cc0c90f41f8f0f41e72389cdde561af81178bf4f89bc4b7ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a782ed1fedfd0f38896eaf127f115a88221f9a55fd97eeb89e1f37c4e2a2f529e9a34f4191b1f40ed8281b2ca9975f43261ebda8bd54d1e5f50e80529cf215bb"} 07:28:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:28:59 INFO - Copying logs to upload dir... 07:28:59 INFO - mkdir: /builds/slave/test/build/upload/logs 07:28:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.828014 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-18 07:28:59.941357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:28:59.944557) ========= 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=574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d0625030c46b6f188bbe6b5ca7e69d52d7c3b2ec44908da77e96ea60150e0a8bbc326f5de93c06cc0c90f41f8f0f41e72389cdde561af81178bf4f89bc4b7ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a782ed1fedfd0f38896eaf127f115a88221f9a55fd97eeb89e1f37c4e2a2f529e9a34f4191b1f40ed8281b2ca9975f43261ebda8bd54d1e5f50e80529cf215bb"} build_url:https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/FGoEGdvlQDuKKR10HVspDg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8d0625030c46b6f188bbe6b5ca7e69d52d7c3b2ec44908da77e96ea60150e0a8bbc326f5de93c06cc0c90f41f8f0f41e72389cdde561af81178bf4f89bc4b7ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a782ed1fedfd0f38896eaf127f115a88221f9a55fd97eeb89e1f37c4e2a2f529e9a34f4191b1f40ed8281b2ca9975f43261ebda8bd54d1e5f50e80529cf215bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:28:59.969290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:28:59.969628) ========= 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=574dc5aafe09851ec43d388c000001b6-1460988116.892478-1910517942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:29:00.055377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:29:00.055751) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:29:00.056104) ========= ========= Total master_lag: 0.19 =========