builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1462789534.32 results: success (0) buildid: 20160509004024 builduid: 17eab2dfe80244199079ba5a0d7ec80a revision: 450bf777896c63ae590821487f918b7e90dab075 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.317814) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.318313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.318605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.332875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.333163) ========= 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=4300f881736b422476174874000001bc-1462789534.211480-881536595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 03:25:34-- 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% 224M=0s 2016-05-09 03:25:34 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.517547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.517877) ========= 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=4300f881736b422476174874000001bc-1462789534.211480-881536595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017457 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.567790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:34.568158) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 450bf777896c63ae590821487f918b7e90dab075 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 450bf777896c63ae590821487f918b7e90dab075 --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=4300f881736b422476174874000001bc-1462789534.211480-881536595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 03:25:35,107 truncating revision to first 12 chars 2016-05-09 03:25:35,107 Setting DEBUG logging. 2016-05-09 03:25:35,107 attempt 1/10 2016-05-09 03:25:35,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/450bf777896c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 03:25:35,368 unpacking tar archive at: mozilla-aurora-450bf777896c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547440 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:35.129087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:35.129465) ========= script_repo_revision: 450bf777896c63ae590821487f918b7e90dab075 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:35.129891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:35.130156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 03:25:35.140463) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-09 03:25:35.140875) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1462789534.211480-881536595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:35 INFO - MultiFileLogger online at 20160509 03:25:35 in /builds/slave/test 03:25:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:25:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:35 INFO - {'append_to_log': False, 03:25:35 INFO - 'base_work_dir': '/builds/slave/test', 03:25:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:25:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:35 INFO - 'branch': 'Mozilla-Aurora', 03:25:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:35 INFO - 'config_files': ('talos/linux_config.py',), 03:25:35 INFO - 'default_actions': ('clobber', 03:25:35 INFO - 'read-buildbot-config', 03:25:35 INFO - 'download-and-extract', 03:25:35 INFO - 'populate-webroot', 03:25:35 INFO - 'create-virtualenv', 03:25:35 INFO - 'install', 03:25:35 INFO - 'run-tests'), 03:25:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:35 INFO - 'download_minidump_stackwalk': True, 03:25:35 INFO - 'download_symbols': 'ondemand', 03:25:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:35 INFO - 'installer_path': 'installer.exe', 03:25:35 INFO - 'log_level': 'info', 03:25:35 INFO - 'log_name': 'talos', 03:25:35 INFO - 'log_to_console': True, 03:25:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:35 INFO - 'opt_config_files': (), 03:25:35 INFO - 'pip_index': False, 03:25:35 INFO - 'sps_profile': False, 03:25:35 INFO - 'sps_profile_interval': 0, 03:25:35 INFO - 'suite': 'dromaeojs', 03:25:35 INFO - 'system_bits': '32', 03:25:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:35 INFO - 'title': 'talos-linux64-ix-045', 03:25:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:35 INFO - 'use_talos_json': True, 03:25:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:35 INFO - 'work_dir': 'build'} 03:25:35 INFO - ##### 03:25:35 INFO - ##### Running clobber step. 03:25:35 INFO - ##### 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: clobber 03:25:35 INFO - rmtree: /builds/slave/test/build 03:25:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:36 INFO - Running post-action listener: _resource_record_post_action 03:25:36 INFO - ##### 03:25:36 INFO - ##### Running read-buildbot-config step. 03:25:36 INFO - ##### 03:25:36 INFO - Running pre-action listener: _resource_record_pre_action 03:25:36 INFO - Running main action method: read_buildbot_config 03:25:36 INFO - Using buildbot properties: 03:25:36 INFO - { 03:25:36 INFO - "project": "", 03:25:36 INFO - "product": "firefox", 03:25:36 INFO - "script_repo_revision": "production", 03:25:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:25:36 INFO - "repository": "", 03:25:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:25:36 INFO - "buildid": "20160509004024", 03:25:36 INFO - "stage_platform": "linux64-pgo", 03:25:36 INFO - "basedir": "/builds/slave/test", 03:25:36 INFO - "nightly_build": "True", 03:25:36 INFO - "buildnumber": 494, 03:25:36 INFO - "slavename": "talos-linux64-ix-045", 03:25:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:25:36 INFO - "platform": "ubuntu64_hw", 03:25:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:25:36 INFO - "branch": "mozilla-aurora", 03:25:36 INFO - "repo_path": "releases/mozilla-aurora", 03:25:36 INFO - "revision": "450bf777896c63ae590821487f918b7e90dab075", 03:25:36 INFO - "pgo_build": "True", 03:25:36 INFO - "builduid": "17eab2dfe80244199079ba5a0d7ec80a", 03:25:36 INFO - "slavebuilddir": "test" 03:25:36 INFO - } 03:25:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:25:36 INFO - Running post-action listener: _resource_record_post_action 03:25:36 INFO - ##### 03:25:36 INFO - ##### Running download-and-extract step. 03:25:36 INFO - ##### 03:25:36 INFO - Running pre-action listener: _resource_record_pre_action 03:25:36 INFO - Running main action method: download_and_extract 03:25:36 INFO - mkdir: /builds/slave/test/build/tests 03:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:36 INFO - https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:25:36 INFO - Downloaded 1361 bytes. 03:25:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:36 INFO - Using the following test package requirements: 03:25:36 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:36 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:36 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:25:36 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'jsshell-linux-x86_64.zip'], 03:25:36 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:36 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:36 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:25:36 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:25:36 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:36 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:36 INFO - https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:38 INFO - Downloaded 23799983 bytes. 03:25:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:39 INFO - Return code: 0 03:25:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:39 INFO - https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:40 INFO - Downloaded 23799983 bytes. 03:25:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:41 INFO - Return code: 0 03:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:41 INFO - https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:25:42 INFO - Downloaded 10840145 bytes. 03:25:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:25:42 INFO - Return code: 0 03:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:43 INFO - https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:25:44 INFO - Downloaded 62716773 bytes. 03:25:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:44 INFO - mkdir: /builds/slave/test/properties 03:25:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:44 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:44 INFO - Contents: 03:25:44 INFO - build_url:https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - Running post-action listener: set_extra_try_arguments 03:25:45 INFO - ##### 03:25:45 INFO - ##### Running populate-webroot step. 03:25:45 INFO - ##### 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: populate_webroot 03:25:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:45 INFO - '--tppagecycles', 03:25:45 INFO - '7'], 03:25:45 INFO - 'tests': ['tsvgm']}}, 03:25:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['damp', 'tps']}, 03:25:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'tests': ['damp', 'tps']}, 03:25:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['dromaeo_dom']}, 03:25:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['a11yr', 03:25:45 INFO - 'ts_paint', 03:25:45 INFO - 'tpaint', 03:25:45 INFO - 'sessionrestore', 03:25:45 INFO - 'sessionrestore_no_auto_restore', 03:25:45 INFO - 'tabpaint']}, 03:25:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tsvgx', 03:25:45 INFO - 'tsvgr_opacity', 03:25:45 INFO - 'tart', 03:25:45 INFO - 'tscrollx', 03:25:45 INFO - 'cart']}, 03:25:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:45 INFO - 'tsvgr_opacity', 03:25:45 INFO - 'tart', 03:25:45 INFO - 'tscrollx', 03:25:45 INFO - 'cart']}, 03:25:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s'], 03:25:45 INFO - 'tests': ['tp5o']}, 03:25:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'tests': ['tp5o']}, 03:25:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--disable-e10s', 03:25:45 INFO - '--xperf_path', 03:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:45 INFO - 'tests': ['tp5n']}, 03:25:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:45 INFO - 'talos_options': ['--xperf_path', 03:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:45 INFO - 'tests': ['tp5n']}}, 03:25:45 INFO - 'talos.zip': {'path': '', 03:25:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:45 INFO - Running post-action listener: _resource_record_post_action 03:25:45 INFO - ##### 03:25:45 INFO - ##### Running create-virtualenv step. 03:25:45 INFO - ##### 03:25:45 INFO - Running pre-action listener: _resource_record_pre_action 03:25:45 INFO - Running main action method: create_virtualenv 03:25:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:45 INFO - Using real prefix '/usr' 03:25:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:45 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:47 INFO - Installing pip.................done. 03:25:47 INFO - Return code: 0 03:25:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:47 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:47 INFO - Using env: {'DISPLAY': ':0', 03:25:47 INFO - 'HOME': '/home/cltbld', 03:25:47 INFO - 'LANG': 'en_US.UTF-8', 03:25:47 INFO - 'LANGUAGE': 'en_US:en', 03:25:47 INFO - 'LOGNAME': 'cltbld', 03:25:47 INFO - 'MAIL': '/var/mail/cltbld', 03:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:47 INFO - 'MOZ_NO_REMOTE': '1', 03:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:47 INFO - 'NO_EM_RESTART': '1', 03:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:47 INFO - 'PWD': '/builds/slave/test', 03:25:47 INFO - 'SHELL': '/bin/bash', 03:25:47 INFO - 'SHLVL': '1', 03:25:47 INFO - 'TERM': 'linux', 03:25:47 INFO - 'TMOUT': '86400', 03:25:47 INFO - 'USER': 'cltbld', 03:25:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:47 INFO - '_': '/tools/buildbot/bin/python'} 03:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:25:48 INFO - Cleaning up... 03:25:48 INFO - Return code: 0 03:25:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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')]} 03:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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', '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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:25: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 psutil>=0.7.1 03:25:48 INFO - Using env: {'DISPLAY': ':0', 03:25:48 INFO - 'HOME': '/home/cltbld', 03:25:48 INFO - 'LANG': 'en_US.UTF-8', 03:25:48 INFO - 'LANGUAGE': 'en_US:en', 03:25:48 INFO - 'LOGNAME': 'cltbld', 03:25:48 INFO - 'MAIL': '/var/mail/cltbld', 03:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:48 INFO - 'MOZ_NO_REMOTE': '1', 03:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:48 INFO - 'NO_EM_RESTART': '1', 03:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:48 INFO - 'PWD': '/builds/slave/test', 03:25:48 INFO - 'SHELL': '/bin/bash', 03:25:48 INFO - 'SHLVL': '1', 03:25:48 INFO - 'TERM': 'linux', 03:25:48 INFO - 'TMOUT': '86400', 03:25:48 INFO - 'USER': 'cltbld', 03:25:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:48 INFO - '_': '/tools/buildbot/bin/python'} 03:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:48 INFO - Downloading/unpacking psutil>=0.7.1 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:50 INFO - Installing collected packages: psutil 03:25:50 INFO - Running setup.py install for psutil 03:25:50 INFO - building 'psutil._psutil_linux' extension 03:25:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:25:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:25:50 INFO - building 'psutil._psutil_posix' extension 03:25:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:25:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:25:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:50 INFO - Successfully installed psutil 03:25:50 INFO - Cleaning up... 03:25:50 INFO - Return code: 0 03:25:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:50 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:25:50 INFO - Using env: {'DISPLAY': ':0', 03:25:50 INFO - 'HOME': '/home/cltbld', 03:25:50 INFO - 'LANG': 'en_US.UTF-8', 03:25:50 INFO - 'LANGUAGE': 'en_US:en', 03:25:50 INFO - 'LOGNAME': 'cltbld', 03:25:50 INFO - 'MAIL': '/var/mail/cltbld', 03:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:50 INFO - 'MOZ_NO_REMOTE': '1', 03:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:50 INFO - 'NO_EM_RESTART': '1', 03:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:50 INFO - 'PWD': '/builds/slave/test', 03:25:50 INFO - 'SHELL': '/bin/bash', 03:25:50 INFO - 'SHLVL': '1', 03:25:50 INFO - 'TERM': 'linux', 03:25:50 INFO - 'TMOUT': '86400', 03:25:50 INFO - 'USER': 'cltbld', 03:25:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:50 INFO - '_': '/tools/buildbot/bin/python'} 03:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:25:52 INFO - Installing collected packages: mozsystemmonitor 03:25:52 INFO - Running setup.py install for mozsystemmonitor 03:25:53 INFO - Successfully installed mozsystemmonitor 03:25:53 INFO - Cleaning up... 03:25:53 INFO - Return code: 0 03:25:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:53 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:25:53 INFO - Using env: {'DISPLAY': ':0', 03:25:53 INFO - 'HOME': '/home/cltbld', 03:25:53 INFO - 'LANG': 'en_US.UTF-8', 03:25:53 INFO - 'LANGUAGE': 'en_US:en', 03:25:53 INFO - 'LOGNAME': 'cltbld', 03:25:53 INFO - 'MAIL': '/var/mail/cltbld', 03:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:53 INFO - 'MOZ_NO_REMOTE': '1', 03:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:53 INFO - 'NO_EM_RESTART': '1', 03:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:53 INFO - 'PWD': '/builds/slave/test', 03:25:53 INFO - 'SHELL': '/bin/bash', 03:25:53 INFO - 'SHLVL': '1', 03:25:53 INFO - 'TERM': 'linux', 03:25:53 INFO - 'TMOUT': '86400', 03:25:53 INFO - 'USER': 'cltbld', 03:25:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:53 INFO - '_': '/tools/buildbot/bin/python'} 03:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:55 INFO - Downloading docopt-0.6.1.tar.gz 03:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:55 INFO - Running setup.py install for blobuploader 03:25:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:56 INFO - Running setup.py install for requests 03:25:56 INFO - Running setup.py install for docopt 03:25:56 INFO - Successfully installed blobuploader requests docopt 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:56 INFO - Running setup.py (path:/tmp/pip-UyJBst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:56 INFO - Running setup.py (path:/tmp/pip-UfgzNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:56 INFO - Running setup.py (path:/tmp/pip-wyS8i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:57 INFO - Running setup.py (path:/tmp/pip-qJWxqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:57 INFO - Running setup.py (path:/tmp/pip-5KDgNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:57 INFO - Running setup.py (path:/tmp/pip-3hqUZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:57 INFO - Running setup.py (path:/tmp/pip-xcqKjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:57 INFO - Running setup.py (path:/tmp/pip-LEJHWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:57 INFO - Running setup.py (path:/tmp/pip-GBMBiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:57 INFO - Running setup.py (path:/tmp/pip-Sq4pjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:57 INFO - Running setup.py (path:/tmp/pip-e_kADn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:57 INFO - Running setup.py (path:/tmp/pip-ZwFhg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:57 INFO - Running setup.py (path:/tmp/pip-nBACjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:57 INFO - Running setup.py (path:/tmp/pip-ZeyR63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:57 INFO - Running setup.py (path:/tmp/pip-lZcMGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:57 INFO - Running setup.py (path:/tmp/pip-2BaC8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:57 INFO - Running setup.py (path:/tmp/pip-cj9zI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:58 INFO - Running setup.py install for manifestparser 03:25:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Running setup.py install for mozcrash 03:25:58 INFO - Running setup.py install for mozdebug 03:25:58 INFO - Running setup.py install for mozdevice 03:25:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Running setup.py install for mozfile 03:25:58 INFO - Running setup.py install for mozhttpd 03:25:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Running setup.py install for mozinfo 03:25:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Running setup.py install for mozInstall 03:25:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:58 INFO - Running setup.py install for mozleak 03:25:58 INFO - Running setup.py install for mozlog 03:25:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for moznetwork 03:25:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozprocess 03:25:59 INFO - Running setup.py install for mozprofile 03:25:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozrunner 03:25:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Running setup.py install for mozscreenshot 03:25:59 INFO - Running setup.py install for moztest 03:25:59 INFO - Running setup.py install for mozversion 03:25:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:59 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:00 INFO - Running setup.py (path:/tmp/pip-LMnkAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:00 INFO - Running setup.py (path:/tmp/pip-S4L8Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:00 INFO - Running setup.py (path:/tmp/pip-LI4r7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:00 INFO - Running setup.py (path:/tmp/pip-YERFdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:00 INFO - Running setup.py (path:/tmp/pip-vmGYrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:00 INFO - Running setup.py (path:/tmp/pip-_1vmqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:00 INFO - Running setup.py (path:/tmp/pip-qV7h55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:00 INFO - Running setup.py (path:/tmp/pip-YzpHft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:00 INFO - Running setup.py (path:/tmp/pip-F_M4z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:00 INFO - Running setup.py (path:/tmp/pip-mUj8hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Running setup.py (path:/tmp/pip-zzBWFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Running setup.py (path:/tmp/pip-jCQGeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Running setup.py (path:/tmp/pip-qDMo5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:00 INFO - Running setup.py (path:/tmp/pip-TgYK1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:01 INFO - Running setup.py (path:/tmp/pip-9ivVAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:01 INFO - Running setup.py (path:/tmp/pip-5kbZJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:01 INFO - Running setup.py (path:/tmp/pip-N9maCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:03 INFO - Downloading blessings-1.6.tar.gz 03:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:03 INFO - Installing collected packages: blessings 03:26:03 INFO - Running setup.py install for blessings 03:26:03 INFO - Successfully installed blessings 03:26:03 INFO - Cleaning up... 03:26:03 INFO - Return code: 0 03:26:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:03 INFO - Reading from file tmpfile_stdout 03:26:03 INFO - Current package versions: 03:26:03 INFO - argparse == 1.2.1 03:26:03 INFO - blessings == 1.6 03:26:03 INFO - blobuploader == 1.2.4 03:26:03 INFO - docopt == 0.6.1 03:26:03 INFO - manifestparser == 1.1 03:26:03 INFO - mozInstall == 1.12 03:26:03 INFO - mozcrash == 0.17 03:26:03 INFO - mozdebug == 0.1 03:26:03 INFO - mozdevice == 0.48 03:26:03 INFO - mozfile == 1.2 03:26:03 INFO - mozhttpd == 0.7 03:26:03 INFO - mozinfo == 0.9 03:26:03 INFO - mozleak == 0.1 03:26:03 INFO - mozlog == 3.1 03:26:03 INFO - moznetwork == 0.27 03:26:03 INFO - mozprocess == 0.22 03:26:03 INFO - mozprofile == 0.28 03:26:03 INFO - mozrunner == 6.11 03:26:03 INFO - mozscreenshot == 0.1 03:26:03 INFO - mozsystemmonitor == 0.0 03:26:03 INFO - moztest == 0.7 03:26:03 INFO - mozversion == 1.4 03:26:03 INFO - psutil == 3.1.1 03:26:03 INFO - requests == 1.2.3 03:26:03 INFO - wsgiref == 0.1.2 03:26:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:03 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:03 INFO - Using env: {'DISPLAY': ':0', 03:26:03 INFO - 'HOME': '/home/cltbld', 03:26:03 INFO - 'LANG': 'en_US.UTF-8', 03:26:03 INFO - 'LANGUAGE': 'en_US:en', 03:26:03 INFO - 'LOGNAME': 'cltbld', 03:26:03 INFO - 'MAIL': '/var/mail/cltbld', 03:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:03 INFO - 'MOZ_NO_REMOTE': '1', 03:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:03 INFO - 'NO_EM_RESTART': '1', 03:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:03 INFO - 'PWD': '/builds/slave/test', 03:26:03 INFO - 'SHELL': '/bin/bash', 03:26:03 INFO - 'SHLVL': '1', 03:26:03 INFO - 'TERM': 'linux', 03:26:03 INFO - 'TMOUT': '86400', 03:26:03 INFO - 'USER': 'cltbld', 03:26:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:03 INFO - '_': '/tools/buildbot/bin/python'} 03:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:03 INFO - Cleaning up... 03:26:03 INFO - Return code: 0 03:26:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:03 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:03 INFO - Using env: {'DISPLAY': ':0', 03:26:03 INFO - 'HOME': '/home/cltbld', 03:26:03 INFO - 'LANG': 'en_US.UTF-8', 03:26:03 INFO - 'LANGUAGE': 'en_US:en', 03:26:03 INFO - 'LOGNAME': 'cltbld', 03:26:03 INFO - 'MAIL': '/var/mail/cltbld', 03:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:03 INFO - 'MOZ_NO_REMOTE': '1', 03:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:03 INFO - 'NO_EM_RESTART': '1', 03:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:03 INFO - 'PWD': '/builds/slave/test', 03:26:03 INFO - 'SHELL': '/bin/bash', 03:26:03 INFO - 'SHLVL': '1', 03:26:03 INFO - 'TERM': 'linux', 03:26:03 INFO - 'TMOUT': '86400', 03:26:03 INFO - 'USER': 'cltbld', 03:26:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:03 INFO - '_': '/tools/buildbot/bin/python'} 03:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:04 INFO - Downloading/unpacking jsonschema 03:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:05 INFO - Downloading/unpacking functools32 (from jsonschema) 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:06 INFO - warning: no files found matching '*.txt' 03:26:06 INFO - no previously-included directories found matching 'build' 03:26:06 INFO - no previously-included directories found matching 'dist' 03:26:06 INFO - no previously-included directories found matching '.git*' 03:26:06 INFO - Installing collected packages: jsonschema, functools32 03:26:06 INFO - Running setup.py install for functools32 03:26:06 INFO - warning: no files found matching '*.txt' 03:26:06 INFO - no previously-included directories found matching 'build' 03:26:06 INFO - no previously-included directories found matching 'dist' 03:26:06 INFO - no previously-included directories found matching '.git*' 03:26:06 INFO - Successfully installed jsonschema functools32 03:26:06 INFO - Cleaning up... 03:26:06 INFO - Return code: 0 03:26:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:06 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 0x7f658d1d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, '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': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:26:06 INFO - Using env: {'DISPLAY': ':0', 03:26:06 INFO - 'HOME': '/home/cltbld', 03:26:06 INFO - 'LANG': 'en_US.UTF-8', 03:26:06 INFO - 'LANGUAGE': 'en_US:en', 03:26:06 INFO - 'LOGNAME': 'cltbld', 03:26:06 INFO - 'MAIL': '/var/mail/cltbld', 03:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:06 INFO - 'MOZ_NO_REMOTE': '1', 03:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:06 INFO - 'NO_EM_RESTART': '1', 03:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:06 INFO - 'PWD': '/builds/slave/test', 03:26:06 INFO - 'SHELL': '/bin/bash', 03:26:06 INFO - 'SHLVL': '1', 03:26:06 INFO - 'TERM': 'linux', 03:26:06 INFO - 'TMOUT': '86400', 03:26:06 INFO - 'USER': 'cltbld', 03:26:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:06 INFO - '_': '/tools/buildbot/bin/python'} 03:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:06 INFO - Downloading/unpacking flake8 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:09 INFO - no previously-included directories found matching 'docs/_build' 03:26:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:09 INFO - Running setup.py install for pep8 03:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:09 INFO - no previously-included directories found matching 'docs/_build' 03:26:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:09 INFO - Cleaning up... 03:26:09 INFO - Return code: 0 03:26:09 INFO - Running post-action listener: _resource_record_post_action 03:26:09 INFO - Running post-action listener: _start_resource_monitoring 03:26:09 INFO - Starting resource monitoring. 03:26:09 INFO - ##### 03:26:09 INFO - ##### Running install step. 03:26:09 INFO - ##### 03:26:09 INFO - Running pre-action listener: _resource_record_pre_action 03:26:09 INFO - Running main action method: install 03:26:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:09 INFO - Reading from file tmpfile_stdout 03:26:09 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:09 INFO - Reading from file tmpfile_stdout 03:26:09 INFO - Output received: 03:26:09 INFO - Usage: mozinstall [options] installer 03:26:09 INFO - Options: 03:26:09 INFO - -h, --help show this help message and exit 03:26:09 INFO - -d DEST, --destination=DEST 03:26:09 INFO - Directory to install application into. [default: 03:26:09 INFO - "/builds/slave/test"] 03:26:09 INFO - --app=APP Application being installed. [default: firefox] 03:26:09 INFO - mkdir: /builds/slave/test/build/application 03:26:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:26:25 INFO - Reading from file tmpfile_stdout 03:26:25 INFO - Output received: 03:26:25 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:25 INFO - Running post-action listener: _resource_record_post_action 03:26:25 INFO - ##### 03:26:25 INFO - ##### Running run-tests step. 03:26:25 INFO - ##### 03:26:25 INFO - Running pre-action listener: _resource_record_pre_action 03:26:25 INFO - Running main action method: run_tests 03:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:25 INFO - Python 2.7.3 03:26:25 INFO - Return code: 0 03:26:25 INFO - grabbing minidump binary from tooltool 03:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:25 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 0x1c4e410>, '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 0x1c4f310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:26:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:26:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:25 INFO - Return code: 0 03:26:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:26:26 INFO - Return code: 0 03:26:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 03:26:26 INFO - Using env: {'DISPLAY': ':0', 03:26:26 INFO - 'HOME': '/home/cltbld', 03:26:26 INFO - 'LANG': 'en_US.UTF-8', 03:26:26 INFO - 'LANGUAGE': 'en_US:en', 03:26:26 INFO - 'LOGNAME': 'cltbld', 03:26:26 INFO - 'MAIL': '/var/mail/cltbld', 03:26:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:26 INFO - 'MOZ_NO_REMOTE': '1', 03:26:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:26 INFO - 'NO_EM_RESTART': '1', 03:26:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:26 INFO - 'PWD': '/builds/slave/test', 03:26:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:26 INFO - 'SHELL': '/bin/bash', 03:26:26 INFO - 'SHLVL': '1', 03:26:26 INFO - 'TERM': 'linux', 03:26:26 INFO - 'TMOUT': '86400', 03:26:26 INFO - 'USER': 'cltbld', 03:26:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462789534.211480-881536595', 03:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:26 INFO - '_': '/tools/buildbot/bin/python'} 03:26:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 03:26:26 INFO - mozversion application_buildid: 20160509004024 03:26:26 INFO - mozversion application_changeset: 450bf777896c63ae590821487f918b7e90dab075 03:26:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:26:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:26 INFO - mozversion application_name: Firefox 03:26:26 INFO - mozversion application_remotingname: firefox-dev 03:26:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:26 INFO - mozversion application_vendor: Mozilla 03:26:26 INFO - mozversion application_version: 48.0a2 03:26:26 INFO - mozversion platform_buildid: 20160509004024 03:26:26 INFO - mozversion platform_changeset: 450bf777896c63ae590821487f918b7e90dab075 03:26:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:26 INFO - mozversion platform_version: 48.0a2 03:26:26 INFO - using testdate: 1462789586 03:26:26 INFO - actual date: 1462789586 03:26:26 INFO - starting webserver on 'localhost:44792' 03:26:26 INFO - SUITE-START | Running 2 tests 03:26:26 INFO - TEST-START | dromaeo_css 03:26:26 INFO - operating with platform_type : linux_ 03:26:26 INFO - Initialising browser for dromaeo_css test... 03:26:26 INFO - TEST-INFO | started process 27372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoh3e7Q/profile http://localhost:44792/getInfo.html) 03:26:30 INFO - PROCESS | 27372 | __metrics Screen width/height:1600/1200 03:26:30 INFO - PROCESS | 27372 | colorDepth:24 03:26:30 INFO - PROCESS | 27372 | Browser inner width/height: 1024/697 03:26:30 INFO - PROCESS | 27372 | __metrics 03:26:31 ERROR - PROCESS | 27372 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:26:32 INFO - TEST-INFO | 27372: exit 0 03:26:32 INFO - Browser initialized. 03:26:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:32 INFO - TEST-INFO | started process 27465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoh3e7Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:44 INFO - PROCESS | 27465 | RSS: Main: 141840384 03:26:44 INFO - PROCESS | 27465 | 03:27:35 INFO - PROCESS | 27465 | 1462789655883 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:29:43 INFO - PROCESS | 27465 | Cycle 1(1): loaded http://localhost:44792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44792/tests/dromaeo/cssquery-ext.html) 03:29:44 INFO - PROCESS | 27465 | RSS: Main: 253001728 03:29:44 INFO - PROCESS | 27465 | 03:32:46 INFO - PROCESS | 27465 | Cycle 1(1): loaded http://localhost:44792/tests/dromaeo/cssquery-ext.html (next: http://localhost:44792/tests/dromaeo/cssquery-jquery.html) 03:32:47 INFO - PROCESS | 27465 | RSS: Main: 230744064 03:32:47 INFO - PROCESS | 27465 | 03:35:49 INFO - PROCESS | 27465 | Cycle 1(1): loaded http://localhost:44792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44792/tests/dromaeo/cssquery-mootools.html) 03:35:50 INFO - PROCESS | 27465 | RSS: Main: 224653312 03:35:50 INFO - PROCESS | 27465 | 03:38:51 INFO - PROCESS | 27465 | Cycle 1(1): loaded http://localhost:44792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44792/tests/dromaeo/cssquery-prototype.html) 03:38:52 INFO - PROCESS | 27465 | RSS: Main: 217710592 03:38:52 INFO - PROCESS | 27465 | 03:41:55 INFO - PROCESS | 27465 | Cycle 1(1): loaded http://localhost:44792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44792/tests/dromaeo/cssquery-yui.html) 03:41:55 INFO - PROCESS | 27465 | RSS: Main: 215252992 03:41:55 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | Cycle 1(1): loaded http://localhost:44792/tests/dromaeo/cssquery-yui.html (next: http://localhost:44792/tests/dromaeo/cssquery-dojo.html) 03:44:58 INFO - PROCESS | 27465 | RSS: Main: 255209472 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | __start_tp_report 03:44:58 INFO - PROCESS | 27465 | _x_x_mozilla_page_load 03:44:58 INFO - PROCESS | 27465 | _x_x_mozilla_page_load_details 03:44:58 INFO - PROCESS | 27465 | |i|pagename|runs| 03:44:58 INFO - PROCESS | 27465 | |0;dojo.html;3354.949675754864;3385.881494147704;3392.5420068290787;3402.2174899773067;3439.2605589798204;5560.638558493695;5563.527100196483;5570.526505247059;5577.86055348616;5579.776808927638;5554.805581804638;5591;5594.49649531542;5602.663840169593;5646.18130371097;5003.849884503453;5073.949260507394;5117.104506711329;5170.844874653748;5213.556847667953;5188.948110518903;5235.973820130894;5236.816711415101;5238.816641417532;5241.816536421226;5106.336176297076;5165.63840531163;5184.585233181337;5205.063088644042;5211.088059589576;5251.921221181667;5268.9736551317;5272.472752724735;5281.947180528184;5311.176767601028;5013.047520971004;5098.541131298164;5173.275741396207;5173.301604283449;5182.093133701587;5524.558035357162;5583.246261754693;5602.663840169562;5607.214989901417;5613.494785469327;6089.117078023706;6143.784967526115;6144.662043587601;6145.354737752561;6147.969260153671;6139.631622102688;6183.350748171467;6210.689465526705;6213.56505044647;6223.968880155616;5762.394948530427;5768.509676677488;5774.653520788766;5776.277965254343;5779.017567013618;6108.22065524731;6272.319201995013;6325.5255855811;6330.968345158245;6333.493320534346;5896.793612223637;5961.940380596138;5966.940330596639;5968.970155149196;6008.939910600925;6046.3651316612;6047.758089676364;6050.939490605126;6053;6053.424924632153;5883.970580147157;6017.548683848729;6027.849303767353;6032.306284777219;6033.577649564489;6083.969580152071;6108.251008765781;6109.34393638171;6112.267354437867;6138.969305153446;4589.173948689201;4620.653450991189;4623.953760462352;4625.583697467244;4672.859814205579;4075.9592404076175;4087.4481944937647;4157.958420415757;4177.310743727251;4183.309753890635;5812.215350927655;5820.592558520862;5829.5336373090895;5833.737481813244;5834.620749651259;6130.509559235251;6159.84600384994;6187;6191.907121393183;6192.81421557354;5621.072523033654;5680.971595141998;5779.3642699303045;5790.189373487715;5815.5929084963645;5262.368515778055;5283.418823929364;5284.603654725911;5291.285676433632;5296.3379577552805;6375.872482550416;6394;6395.456386207132;6398.648074355955;6401.519886008568;6063.757449701962;6116.418940200763;6124.496488522206;6152;6156.076588511759;6332.366763323631;6350.936490635035;6353.555251132377;6357.586756860789;6362.204724409449;5794.449527294901;6017.097435384552;6030.276366836008;6031.75872965094;6039.849003774765;6117.694115294128;6152.600080994721;6187.597806142587;6190.690465476618;6191.102290167991;6001.417264679211;6007.369226231182;6013.098035294741;6017.3681763414215;6051.848703782441;5740.167675687086;5833.125031245348;5936.406359364029;5988.820335389945;6004.519638429003;5812.593118481665;5813;5847.678377689098;5851.824445266649;5886.705664716833;5951.761929522944;5957.225560677084;5971.253593300838;5983.521318294439;5992.250968628921;5723.828285151452;5765.91351129725;5833.183354330482;5858.736356863866;5864.530837533072 03:44:58 INFO - PROCESS | 27465 | |1;ext.html;618.0574623698859;660.207750699161;661.2329697550836;663.127986697493;671.3085521912429;33525.83237083814;39879;40614.39078413826;40638.593614063815;40749.388759168636;42689.78655106728;43209.567904320946;43286.567134328645;43290.567094329046;43293.78353108238;8135.186481351847;8821.117888211193;8976.865347019768;9025.18773310402;10405.583776648926;10449.529771160316;10598.258121931429;10599.417032063233;10604;10609.84085238722;10577.20670949678;10615.946920265427;10673.039426451618;10683.83974240387;10687.412192329419;8441.07148213696;8651.870221946676;10517.368957862553;10542.736431589234;10680.51937662807;10653.414062226575;10776.78446431067;10779;10788.190885683527;10806.081483073947;39941.60058399408;40527.59472405268;40541.59458405407;40553.391699124535;40576.79711601423;3926.469926559935;4006.1186538961383;4267.871963841089;4340.565943405666;4452.5547445255215;33644;34032;34271.6572834271;34502.137446563785;34926.82536587301;4418.094290670405;4503.77548639485;4521.231390663595;4633.652476064275;4666.813327466897;267382;268319;269638;270027;270278.999999998;39873.202535949116;41600.79199603983;64924;65732.34267657358;65743.67128164425;33219.66780332214;33435;33492;33506;33556.49665255023;16124.838751612568;16309.102999334913;16348.509544713677;16361.754573681405;16372.754408683879;11232.66302010941;13736.519221827188;14010.229437380838;14018.29908504591;14049.71900561983;9366;9381.437113773196;9400.435973841591;9418.952905235567;9490.762730931643;3516.82415879205;3629.2015756534047;3642.2715456908722;3663.7984910829628;3668.5781135169264;1088.967330980072;1095.912327013837;1159.2696601141226;1162.0471213604762;1179.7935361311736;34509.13727156841;34999;35104.64895351065;35181.120471988404;35335;1175.753091850721;1196.0670676872053;1237.3132911234352;1243.4590952935503;1269.3526301586073;17540.561485962953;17930.641387172185;17992.460226193234;18128.45614631563;18194.52347438938;495885;500382;503971;504605;506254;62581.374186258465;63233;63252.05121923175;63259.6837015812;63341;1401.70564181521;1491.8065547561907;1550.2636247782214;1583.4299652125226;1588.253520845224;29375.559366609945;32090.19774505656;33031.33937321288;33660.158496037795;34075;51460.74269628628;51869.7406512965;52155.73922130365;52251.73874130605;52277;377109;377294;378795;379235;380224;27446.5883011751;30354;30777.692223077484;30881.536776948815;31490.527642085846;43637.12725745531;43804.34293485536;43916.78041609772;44226.55773442353;44465.55534444614;37588.81205593955;37714.622853772205;37813.24373512459;38078.8096059529;38194.809025954695;37006.074848129014;37241;37943.81028094842;38211.61788382081;38286.80856595699;41620.375694364004;42284;42482.56555102783;42876.78561607172;42941.78529107334;34767.65232347644;35686.28627427385;36438.8178059108;36801.447978279815;37110.44334335041;27841.303967400978;28138.644655780456;28239.021192921064;28325.858370708014;28524.429511409242 03:44:58 INFO - PROCESS | 27465 | |2;jquery.html;407.90210349516127;410.1939688512074;415.93552999285123;421.6247539689676;421.7090207756648;14737.336819843105;18229.90356109048;18992.240310387584;19025.143868525916;19075.427737167873;16390.918045409755;20286.18855245792;20964.8951755241;21184;21273.57452850942;5667.263255776754;5819.738111784959;5844.64932104073;5867.1492633568105;5879.11813228017;4288.335308027261;5704.942950570483;5796.130580412951;5989.490893274077;6431.903521447182;6347.873042539147;6356.173697419329;6386;6388.7125079371535;6390.808275751735;6090.5736598438125;6255.311915689271;6269.937300627003;6270.561060725751;6335.651539165344;5524.530414914737;5525.834224973257;5539.058360078796;5545.3622833374275;5577.9163312550345;24148.39629009271;25046.37384065413;25504.617430738555;25536;25564.87217563919;2416.903323867043;2514.208024472285;2551.1326149109204;2556.6676332076713;2655.49545586338;14436.422543098264;14524.273786310641;14688.265586720621;15065.472708455261;15378.384864605403;2022.5550378916614;2063.8245749111343;2113.4399384163207;2132.5201829588373;2163.8809865457392;78445.21554784436;78673.60663196705;82786;83297.58351208265;83678.16321836825;10393.960603939546;10597;10720.820709721924;10778.083862871586;10839.187060970458;14612.561623151323;14629.707405852036;14674;14695.77956330656;14711.92644036773;8166.714165004197;8345.54099524532;8384.832303353898;8476.745697629081;8476.872846907301;6789.219239787389;8372.874406883902;8375.495215000677;8415.579221038923;8481.321494280442;5982.312034116046;6305.747770089237;6322.178116844872;6527.608343499405;6549.541532092708;1823.6535058338873;1835.9265629374943;1866.5986812835033;1929.7684277886462;1933.8162874526897;1098.8681358236902;1137.1414581990543;1167.5988813423926;1168.7253495428567;1233.2600439736086;20479;20591.382258532267;20830.79169208319;21164.259250926145;21500.78499214988;1088.9618863339745;1094.261373572851;1103.3545375954996;1151.4530597966066;1191.8927296543352;11699.824502632468;11903.226290291102;12132.15074944763;12132.696682583006;12157.027437804954;503206;518888;520001;539888;547134;77218;93103.53448232716;93413;94997.52501237449;96797.51601241948;1097.1551905033239;1128.638835572609;1128.7516746315798;1128.8081026225725;1135.5628083188033;18742.15660295317;18984;19000.619987600447;19071;19216.807831922062;39714.801425992686;40382.596174037884;40406.39390409205;41258.174836503706;41259.587404125574;55469.1679624814;59385.703071484364;59530.70234648799;59844.40155598388;59917.700411497666;7075.398591119812;8737.56312184401;9014.414063085878;9127.315451341308;9410.29422793307;13816.654583635489;13853.861461385257;14074.437022519394;14758.704825903207;14817.333220005341;12495.312757798409;12576.685582860502;12739.044571657349;13010.934945325213;13137.540186093442;12329.876701233232;12763.48946042185;12894.355282236038;13029.15310504814;13097.672558186121;13018.804717929428;13059;13132.40904159296;13168.683131686754;13199.802002970155;9160.358774885693;9167.816643667224;9209.815803684023;9255.120763527455;9375.8967711291;12794.296313702836;12834;12853.586105528571;12912.483500659868;13020.739585208432 03:44:58 INFO - PROCESS | 27465 | |3;mootools.html;1381.702933869218;1531.5022617649263;1536.5697604670693;1747.5893165106206;1853.2957476159058;8194.795130121742;8427.494350338977;8432.241098301152;8449.155084491547;8450.704225352114;8205.22050405212;8313.41806073575;8330.375221858354;8344.45761025533;8395.496270223792;2094.4030951178916;2340.473393486469;2398.436367453647;2400.1239547565187;2429.829911906167;2375.489269806991;2385.189035727852;2388.128333158393;2388.9641655375094;2390.306811024801;2327.674125622406;2393.892274847636;2396.1373905394044;2396.376941995085;2398.1486572266854;2063.515073957619;2387.3315471667875;2441.011390386896;2445.75542445754;2447.9877600612062;2289.8969546370286;2345.835791494596;2350.365401341628;2352.4589344450874;2385.6898603181476;8371.95814020932;8409.075001749803;8433.578321083982;8468.449550779242;8471.618777155043;5149.48505149482;5248.422673505911;5262.02652509287;5265.842024739264;5306.522412982811;3332.616749073839;3357.446021406465;3416.26550291686;3421.794692318469;3424.7773894696766;1038.8130136575414;1059.348500672089;1064.6273804168557;1064.7072055184808;1067.8167757287345;12263.080268979862;12281.263124212575;12299.262044277282;12323.815142772775;12327.075469339745;4662.53374662531;4720.409948756405;4760.143174228672;4764.404449443819;4817.445993710698;10520.579176832995;10526.368417894952;10542.789144217073;10546.367217966947;10555.10281626055;4878.926816097762;5443.755031023614;5444.646098003617;5477.452254774491;5495.065838807413;4862.197737373293;4959.628027897922;4960.553550180501;4963.503649635008;4995.075910956485;4116.238495878272;4122.855700050483;4180.226658068267;4216.852410165691;4225.492940847118;1303.2571434282559;1328.7908003716764;1340.222670850904;1340.443715857908;1341.3092257487401;948.3788118782209;964.6286179820679;1004.5228516454772;1004.9397885231151;1045.153425725165;5999.730012149464;6003.519718422515;6046.606970546901;6077.3314935357075;6251.156093927261;461.90069135136105;470.33682507664713;472.52983281634994;476.48301592771537;477.77305779755034;4066.573009833925;4199;4221.029163292398;4222.451081359403;4230.61924426803;10295;10703.46482675863;10728.570857165625;10734.570617175226;10736;9821.361611495373;10222.335548189343;10430.26988110825;10573.418461984511;10595.682129536126;7860.882086768703;7929.246721561442;7948.801279968047;7976.641051152712;8047.235512626291;5781.4218578141845;5969.582129250911;5986.431289027535;6017.428344307284;6065.5754097212775;9192.724218273463;9247.39891907024;9304.348695591243;9429.245660347018;9439.05609439078;9581.856272155785;9628.47043412619;9666.95166524163;9834.557444914853;10129.189664826943;7142.535735177197;7148.142222933281;7295.708171673074;7387.7783666490095;7402.074740657418;7902.960485197767;7916.960415197887;7930.801729956797;7961.6019199040975;7966;7166.820829479097;7263.782086537412;7322.487425880137;7359.963200183965;7363.631818408951;7015.789526314219;7065.258147894603;7078;7092.503524753218;7171.1394632644415;6617.503687223574;6682.298358672464;6685.699143538455;6693.397594216543;6693.598384096969;4958.082754690394;5020.748962551931;5024.246363045572;5044.848654540223;5072.771725272445;5068.847934561969;5103.897922041612;5109.821156259513;5169.81905633301;5268.710220937885 03:44:58 INFO - PROCESS | 27465 | |4;prototype.html;354.70559435668395;355.8149762123694;356.54006331831937;358.533905922301;363.28795560701025;6246.156768836206;6249.156363890874;6304.684765761716;6350.364963503647;6351.872962540758;6267.968660156693;6275.466585340251;6292.528060395477;6296.590721603104;6309.526785491095;4543.931841022379;4700.083483720676;4820.8071677132875;4847.612191024709;4850.490698476662;4796.97601511992;4822.782974766126;4826.7586620669;4836.6856154350035;4852.514748525155;4511.639068874499;4801.327814106028;4801.663883528155;4802.927956080662;4811.182099043153;4605.4473463184295;4621.260598304289;4630.21286381316;4700.106979673851;4704.411948506437;4115.218108559364;4116.197341518405;4123.36087906372;4128.772917489537;4140.441040459529;5947.137665038588;5950;6007.969960150215;6043.758249670008;6049.304330002062;5514.420985796514;5529.30883639545;5531.806386776484;5533.474319939599;5544.473275038865;6405.391487808697;6564.343565643445;6566.409023187936;6571.605703657796;6575.769848055343;4636.188666983265;4638;4638.072385522909;4643.373144625466;4651.790669419885;6783.796486105425;6890.793276201672;6905.343992320722;6915.619640919747;6916.6541672916155;4673.415823022122;4704.85885423431;4707.31743897133;4710.081534100886;4710.788014539354;4765.594924431392;4769.499202583748;4773.856784296477;4774.928376074362;4775.474697783241;5495.203195536625;5495.53287970527;5507.311586051744;5509.118541033416;5510.724463776875;6474.0612611172055;6643.638054198877;6717.731290748316;6720.092787473726;6728.058071869942;1682.0664531185064;1693.5766058485378;1701.5150682055803;1701.5235733994502;1701.6256423587038;1119.6361182615683;1120.3222050659397;1130.4178348150708;1132.3432409202642;1140.9258398204256;6278.30938596754;6491.772787952399;6643.800685979429;6645.933540664628;6659.800205993828;6919;6941.236463988957;6945.722171113099;6951.7914462566205;6961.686724097428;6559.180102487189;6565.901511477332;6568.310327415553;6576.408123268929;6581.703823327962;3702.61122582125;3743.989122936792;3745.3071181831447;3747.7563958343167;3749.606291339425;7007.1591409030225;7176.425885929218;7186.6047367395295;7214.855702886018;7242.927570724225;7112.324329188718;7122.430205583541;7123.394511466583;7133.179684336264;7138.821529461805;7232.0598322217775;7252.311030452099;7254.528455650471;7263.3826124778925;7269.418446524372;6961.408280296231;6964.233934267125;6969.860602788017;6972.093627828553;6972.4073453757;6731.32686731323;6809.89785153233;6858.074159988338;6869.0383346330555;6872.62200578973;7228.49400541957;7232.493725439169;7235.746748863765;7240.203577606564;7250.709971601077;4498.28027515609;4524.547545245449;4527.84152554659;4531.320301954733;4540.091981603627;6874.621895795779;6916.412104970933;6928.445724342141;6934.653267336714;6935.653217339213;6492.513061520499;6693.531452798257;6745.628990405575;6764.154480689914;6769.796906092825;6716.529842910949;6749.4600431964345;6755.898661519983;6761.188657361148;6763.323667633197;6621.966890165519;6624.370684784938;6627.37039981201;6631.568948018364;6634.734610615521;6788.796336109727;6803.625800581016;6819.624920629413;6832.965835170792;6888.724451021903;6440.2271727391135;6581.243157037002;6583.44040756541;6587.176602924635;6608.306127856506 03:44:58 INFO - PROCESS | 27465 | |5;yui.html;793.0721056364054;824.4064273722921;846.9239503944543;902.2736696958946;920.7283851263876;15312.846871531281;15548.45580404686;15560;15600.141992190425;15611.297491612877;14597.635059123528;14600.342984565694;14653.047551909118;14670.119792812413;14703.779443308358;750.4296734481792;763.0461922596754;763.7594157840263;764.2281295891162;896.5830888636783;887.5029983209391;889.4396530186007;890;890.0120865838913;890.2255038116815;955.044955044955;959.4627008875018;961.5624890674726;962.4129281138535;962.4754508792724;956.8469044952843;958.7123862841155;959.3811991265629;959.5538074795219;960.6493629825134;582.3943099176851;686.306830101601;695.9443244540424;697.0554898113035;699.9440044796404;15040.924795376062;15078.095314281178;15098.396064157421;15126.621834454116;15130.319135638923;14330.140191588538;14413.351399186957;15075.924620376938;15630.531084067496;15912;12017.51929922802;12357.443915023845;12380.276339205451;12384.195027323196;12625;4080.367543030835;4083;4123.402106694542;4149.087200815816;4212.473440819897;58656.41343586552;58658.12012819768;58837.82324353489;59366.10950835741;59379;11449.626044874669;11671;11768.646940591796;11831.585894493823;12006.21959572625;21884.343469695934;21948;22048.11807527713;22051.11795528161;22107.447313817283;8294.294984926228;8394.622241999125;8510.78723031929;8517.06312305646;8744.387892847439;5074.467180945948;5097.082525145435;5114.411842638145;5149.6910185389;5275.103232450492;3427.5715535558056;3492.336456073338;3503.211777350076;3504.649535046526;3507.473878918183;602.5842168903442;609.9298580663192;612.5773216480615;628.4501061571125;640.3436477610486;635.5297080160648;680.4556354916048;700.6181631011111;718.5832217313946;725.8076609698434;9503;9815.165710914653;9909.55407006672;9958.15355694774;9985.550650220757;707.886738121898;738.5863916206941;753.333300029467;759.2407592407592;776.4293244465314;4465.508794032654;4539.682222244412;4614.192516309699;4698.060387922429;4712.717236965793;71272.64363678149;71791.28208717846;71909.2809071913;72081.2791872085;72495;61581;62483.99999999909;63499.682501587195;63541;64449;55253.447465525634;55316.17025744617;56545.71727141338;57370.13944790832;57596;8756.605952732016;8817.559122043744;8819.294456443597;9060.954695226745;9146.862797058182;35939.64060359363;37375.252494950495;37521.437178441796;37810;38190.80904595459;45817.77091114523;46230.537694622624;47220.527794722984;49971.250431242835;50201.49798501968;11580.247283926517;11659.358735269641;11763.823542646696;11837.171398002401;12258;12096.153269271066;12201.938990304992;12301.815472767737;12552.372381381078;12592.370381481072;10587.947060264649;12029.278243305429;12112.939435302767;12259.264444133381;12383.442745076673;12416.317102559085;12861.228326300452;13146.21122732639;13281.60155195307;13415.262160581262;12785.36073196318;12793;12945.805812912626;13004.869951300745;13070.934645326712;10932.672019839418;10993.175511836484;11045.889541104487;11047.72380690489;11051.281666691639;10575.841362379724;10707.357558546511;10867.13062954946;11143.275687080313;11219.158563107636 03:44:58 INFO - PROCESS | 27465 | __end_tp_report 03:44:58 INFO - PROCESS | 27465 | __start_cc_report 03:44:58 INFO - PROCESS | 27465 | _x_x_mozilla_cycle_collect,855 03:44:58 INFO - PROCESS | 27465 | __end_cc_report 03:44:58 INFO - PROCESS | 27465 | __startTimestamp1462790698293__endTimestamp 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | ------- Summary: start ------- 03:44:58 INFO - PROCESS | 27465 | Number of tests: 6 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | [#0] dojo.html Cycles:165 Average:5663.96 Median:5834.62 stddev:643.34 (11.0%) stddev-sans-first:619.29 03:44:58 INFO - PROCESS | 27465 | Values: 3354.9 3385.9 3392.5 3402.2 3439.3 5560.6 5563.5 5570.5 5577.9 5579.8 5554.8 5591.0 5594.5 5602.7 5646.2 5003.8 5073.9 5117.1 5170.8 5213.6 5188.9 5236.0 5236.8 5238.8 5241.8 5106.3 5165.6 5184.6 5205.1 5211.1 5251.9 5269.0 5272.5 5281.9 5311.2 5013.0 5098.5 5173.3 5173.3 5182.1 5524.6 5583.2 5602.7 5607.2 5613.5 6089.1 6143.8 6144.7 6145.4 6148.0 6139.6 6183.4 6210.7 6213.6 6224.0 5762.4 5768.5 5774.7 5776.3 5779.0 6108.2 6272.3 6325.5 6331.0 6333.5 5896.8 5961.9 5966.9 5969.0 6008.9 6046.4 6047.8 6050.9 6053.0 6053.4 5884.0 6017.5 6027.8 6032.3 6033.6 6084.0 6108.3 6109.3 6112.3 6139.0 4589.2 4620.7 4624.0 4625.6 4672.9 4076.0 4087.4 4158.0 4177.3 4183.3 5812.2 5820.6 5829.5 5833.7 5834.6 6130.5 6159.8 6187.0 6191.9 6192.8 5621.1 5681.0 5779.4 5790.2 5815.6 5262.4 5283.4 5284.6 5291.3 5296.3 6375.9 6394.0 6395.5 6398.6 6401.5 6063.8 6116.4 6124.5 6152.0 6156.1 6332.4 6350.9 6353.6 6357.6 6362.2 5794.4 6017.1 6030.3 6031.8 6039.8 6117.7 6152.6 6187.6 6190.7 6191.1 6001.4 6007.4 6013.1 6017.4 6051.8 5740.2 5833.1 5936.4 5988.8 6004.5 5812.6 5813.0 5847.7 5851.8 5886.7 5951.8 5957.2 5971.3 5983.5 5992.3 5723.8 5765.9 5833.2 5858.7 5864.5 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | [#1] ext.html Cycles:180 Average:54441.35 Median:20051.31 stddev:104619.91 (521.8%) stddev-sans-first:104835.34 03:44:58 INFO - PROCESS | 27465 | Values: 618.1 660.2 661.2 663.1 671.3 33525.8 39879.0 40614.4 40638.6 40749.4 42689.8 43209.6 43286.6 43290.6 43293.8 8135.2 8821.1 8976.9 9025.2 10405.6 10449.5 10598.3 10599.4 10604.0 10609.8 10577.2 10615.9 10673.0 10683.8 10687.4 8441.1 8651.9 10517.4 10542.7 10680.5 10653.4 10776.8 10779.0 10788.2 10806.1 39941.6 40527.6 40541.6 40553.4 40576.8 3926.5 4006.1 4267.9 4340.6 4452.6 33644.0 34032.0 34271.7 34502.1 34926.8 4418.1 4503.8 4521.2 4633.7 4666.8 267382.0 268319.0 269638.0 270027.0 270279.0 39873.2 41600.8 64924.0 65732.3 65743.7 33219.7 33435.0 33492.0 33506.0 33556.5 16124.8 16309.1 16348.5 16361.8 16372.8 11232.7 13736.5 14010.2 14018.3 14049.7 9366.0 9381.4 9400.4 9419.0 9490.8 3516.8 3629.2 3642.3 3663.8 3668.6 1089.0 1095.9 1159.3 1162.0 1179.8 34509.1 34999.0 35104.6 35181.1 35335.0 1175.8 1196.1 1237.3 1243.5 1269.4 17540.6 17930.6 17992.5 18128.5 18194.5 495885.0 500382.0 503971.0 504605.0 506254.0 62581.4 63233.0 63252.1 63259.7 63341.0 1401.7 1491.8 1550.3 1583.4 1588.3 29375.6 32090.2 33031.3 33660.2 34075.0 51460.7 51869.7 52155.7 52251.7 52277.0 377109.0 377294.0 378795.0 379235.0 380224.0 27446.6 30354.0 30777.7 30881.5 31490.5 43637.1 43804.3 43916.8 44226.6 44465.6 37588.8 37714.6 37813.2 38078.8 38194.8 37006.1 37241.0 37943.8 38211.6 38286.8 41620.4 42284.0 42482.6 42876.8 42941.8 34767.7 35686.3 36438.8 36801.4 37110.4 27841.3 28138.6 28239.0 28325.9 28524.4 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | [#2] jquery.html Cycles:180 Average:30542.82 Median:13282.65 stddev:86441.92 (650.8%) stddev-sans-first:86654.80 03:44:58 INFO - PROCESS | 27465 | Values: 407.9 410.2 415.9 421.6 421.7 14737.3 18229.9 18992.2 19025.1 19075.4 16390.9 20286.2 20964.9 21184.0 21273.6 5667.3 5819.7 5844.6 5867.1 5879.1 4288.3 5704.9 5796.1 5989.5 6431.9 6347.9 6356.2 6386.0 6388.7 6390.8 6090.6 6255.3 6269.9 6270.6 6335.7 5524.5 5525.8 5539.1 5545.4 5577.9 24148.4 25046.4 25504.6 25536.0 25564.9 2416.9 2514.2 2551.1 2556.7 2655.5 14436.4 14524.3 14688.3 15065.5 15378.4 2022.6 2063.8 2113.4 2132.5 2163.9 78445.2 78673.6 82786.0 83297.6 83678.2 10394.0 10597.0 10720.8 10778.1 10839.2 14612.6 14629.7 14674.0 14695.8 14711.9 8166.7 8345.5 8384.8 8476.7 8476.9 6789.2 8372.9 8375.5 8415.6 8481.3 5982.3 6305.7 6322.2 6527.6 6549.5 1823.7 1835.9 1866.6 1929.8 1933.8 1098.9 1137.1 1167.6 1168.7 1233.3 20479.0 20591.4 20830.8 21164.3 21500.8 1089.0 1094.3 1103.4 1151.5 1191.9 11699.8 11903.2 12132.2 12132.7 12157.0 503206.0 518888.0 520001.0 539888.0 547134.0 77218.0 93103.5 93413.0 94997.5 96797.5 1097.2 1128.6 1128.8 1128.8 1135.6 18742.2 18984.0 19000.6 19071.0 19216.8 39714.8 40382.6 40406.4 41258.2 41259.6 55469.2 59385.7 59530.7 59844.4 59917.7 7075.4 8737.6 9014.4 9127.3 9410.3 13816.7 13853.9 14074.4 14758.7 14817.3 12495.3 12576.7 12739.0 13010.9 13137.5 12329.9 12763.5 12894.4 13029.2 13097.7 13018.8 13059.0 13132.4 13168.7 13199.8 9160.4 9167.8 9209.8 9255.1 9375.9 12794.3 12834.0 12853.6 12912.5 13020.7 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | [#3] mootools.html Cycles:180 Average:5660.22 Median:4958.86 stddev:3160.58 (63.7%) stddev-sans-first:3153.09 03:44:58 INFO - PROCESS | 27465 | Values: 1381.7 1531.5 1536.6 1747.6 1853.3 8194.8 8427.5 8432.2 8449.2 8450.7 8205.2 8313.4 8330.4 8344.5 8395.5 2094.4 2340.5 2398.4 2400.1 2429.8 2375.5 2385.2 2388.1 2389.0 2390.3 2327.7 2393.9 2396.1 2396.4 2398.1 2063.5 2387.3 2441.0 2445.8 2448.0 2289.9 2345.8 2350.4 2352.5 2385.7 8372.0 8409.1 8433.6 8468.4 8471.6 5149.5 5248.4 5262.0 5265.8 5306.5 3332.6 3357.4 3416.3 3421.8 3424.8 1038.8 1059.3 1064.6 1064.7 1067.8 12263.1 12281.3 12299.3 12323.8 12327.1 4662.5 4720.4 4760.1 4764.4 4817.4 10520.6 10526.4 10542.8 10546.4 10555.1 4878.9 5443.8 5444.6 5477.5 5495.1 4862.2 4959.6 4960.6 4963.5 4995.1 4116.2 4122.9 4180.2 4216.9 4225.5 1303.3 1328.8 1340.2 1340.4 1341.3 948.4 964.6 1004.5 1004.9 1045.2 5999.7 6003.5 6046.6 6077.3 6251.2 461.9 470.3 472.5 476.5 477.8 4066.6 4199.0 4221.0 4222.5 4230.6 10295.0 10703.5 10728.6 10734.6 10736.0 9821.4 10222.3 10430.3 10573.4 10595.7 7860.9 7929.2 7948.8 7976.6 8047.2 5781.4 5969.6 5986.4 6017.4 6065.6 9192.7 9247.4 9304.3 9429.2 9439.1 9581.9 9628.5 9667.0 9834.6 10129.2 7142.5 7148.1 7295.7 7387.8 7402.1 7903.0 7917.0 7930.8 7961.6 7966.0 7166.8 7263.8 7322.5 7360.0 7363.6 7015.8 7065.3 7078.0 7092.5 7171.1 6617.5 6682.3 6685.7 6693.4 6693.6 4958.1 5020.7 5024.2 5044.8 5072.8 5068.8 5103.9 5109.8 5169.8 5268.7 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | [#4] prototype.html Cycles:180 Average:5593.71 Median:6378.63 stddev:1710.12 (26.8%) stddev-sans-first:1669.10 03:44:58 INFO - PROCESS | 27465 | Values: 354.7 355.8 356.5 358.5 363.3 6246.2 6249.2 6304.7 6350.4 6351.9 6268.0 6275.5 6292.5 6296.6 6309.5 4543.9 4700.1 4820.8 4847.6 4850.5 4797.0 4822.8 4826.8 4836.7 4852.5 4511.6 4801.3 4801.7 4802.9 4811.2 4605.4 4621.3 4630.2 4700.1 4704.4 4115.2 4116.2 4123.4 4128.8 4140.4 5947.1 5950.0 6008.0 6043.8 6049.3 5514.4 5529.3 5531.8 5533.5 5544.5 6405.4 6564.3 6566.4 6571.6 6575.8 4636.2 4638.0 4638.1 4643.4 4651.8 6783.8 6890.8 6905.3 6915.6 6916.7 4673.4 4704.9 4707.3 4710.1 4710.8 4765.6 4769.5 4773.9 4774.9 4775.5 5495.2 5495.5 5507.3 5509.1 5510.7 6474.1 6643.6 6717.7 6720.1 6728.1 1682.1 1693.6 1701.5 1701.5 1701.6 1119.6 1120.3 1130.4 1132.3 1140.9 6278.3 6491.8 6643.8 6645.9 6659.8 6919.0 6941.2 6945.7 6951.8 6961.7 6559.2 6565.9 6568.3 6576.4 6581.7 3702.6 3744.0 3745.3 3747.8 3749.6 7007.2 7176.4 7186.6 7214.9 7242.9 7112.3 7122.4 7123.4 7133.2 7138.8 7232.1 7252.3 7254.5 7263.4 7269.4 6961.4 6964.2 6969.9 6972.1 6972.4 6731.3 6809.9 6858.1 6869.0 6872.6 7228.5 7232.5 7235.7 7240.2 7250.7 4498.3 4524.5 4527.8 4531.3 4540.1 6874.6 6916.4 6928.4 6934.7 6935.7 6492.5 6693.5 6745.6 6764.2 6769.8 6716.5 6749.5 6755.9 6761.2 6763.3 6622.0 6624.4 6627.4 6631.6 6634.7 6788.8 6803.6 6819.6 6833.0 6888.7 6440.2 6581.2 6583.4 6587.2 6608.3 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - PROCESS | 27465 | [#5] yui.html Cycles:180 Average:16050.48 Median:4705.39 stddev:19249.09 (409.1%) stddev-sans-first:19268.99 03:44:58 INFO - PROCESS | 27465 | Values: 793.1 824.4 846.9 902.3 920.7 15312.8 15548.5 15560.0 15600.1 15611.3 14597.6 14600.3 14653.0 14670.1 14703.8 750.4 763.0 763.8 764.2 896.6 887.5 889.4 890.0 890.0 890.2 955.0 959.5 961.6 962.4 962.5 956.8 958.7 959.4 959.6 960.6 582.4 686.3 695.9 697.1 699.9 15040.9 15078.1 15098.4 15126.6 15130.3 14330.1 14413.4 15075.9 15630.5 15912.0 12017.5 12357.4 12380.3 12384.2 12625.0 4080.4 4083.0 4123.4 4149.1 4212.5 58656.4 58658.1 58837.8 59366.1 59379.0 11449.6 11671.0 11768.6 11831.6 12006.2 21884.3 21948.0 22048.1 22051.1 22107.4 8294.3 8394.6 8510.8 8517.1 8744.4 5074.5 5097.1 5114.4 5149.7 5275.1 3427.6 3492.3 3503.2 3504.6 3507.5 602.6 609.9 612.6 628.5 640.3 635.5 680.5 700.6 718.6 725.8 9503.0 9815.2 9909.6 9958.2 9985.6 707.9 738.6 753.3 759.2 776.4 4465.5 4539.7 4614.2 4698.1 4712.7 71272.6 71791.3 71909.3 72081.3 72495.0 61581.0 62484.0 63499.7 63541.0 64449.0 55253.4 55316.2 56545.7 57370.1 57596.0 8756.6 8817.6 8819.3 9061.0 9146.9 35939.6 37375.3 37521.4 37810.0 38190.8 45817.8 46230.5 47220.5 49971.3 50201.5 11580.2 11659.4 11763.8 11837.2 12258.0 12096.2 12201.9 12301.8 12552.4 12592.4 10587.9 12029.3 12112.9 12259.3 12383.4 12416.3 12861.2 13146.2 13281.6 13415.3 12785.4 12793.0 12945.8 13004.9 13070.9 10932.7 10993.2 11045.9 11047.7 11051.3 10575.8 10707.4 10867.1 11143.3 11219.2 03:44:58 INFO - PROCESS | 27465 | -------- Summary: end -------- 03:44:58 INFO - PROCESS | 27465 | 03:44:58 INFO - TEST-INFO | 27465: exit 0 03:44:58 INFO - TEST-OK | dromaeo_css | took 1112240ms 03:44:58 INFO - TEST-START | kraken 03:44:58 INFO - operating with platform_type : linux_ 03:44:58 INFO - Initialising browser for kraken test... 03:44:58 INFO - TEST-INFO | started process 27661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxKpiY5/profile http://localhost:44792/getInfo.html) 03:45:03 INFO - PROCESS | 27661 | __metrics Screen width/height:1600/1200 03:45:03 INFO - PROCESS | 27661 | colorDepth:24 03:45:03 INFO - PROCESS | 27661 | Browser inner width/height: 1024/697 03:45:03 INFO - PROCESS | 27661 | __metrics 03:45:04 ERROR - PROCESS | 27661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:45:04 INFO - TEST-INFO | 27661: exit 0 03:45:04 INFO - Browser initialized. 03:45:04 INFO - Running cycle 1/1 for kraken test... 03:45:04 INFO - TEST-INFO | started process 27755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxKpiY5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:16 INFO - PROCESS | 27755 | RSS: Main: 142319616 03:45:16 INFO - PROCESS | 27755 | 03:45:19 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44792/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:19 INFO - PROCESS | 27755 | RSS: Main: 196571136 03:45:19 INFO - PROCESS | 27755 | 03:45:22 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44792/tests/kraken/driver.html?testName=audio-dft) 03:45:23 INFO - PROCESS | 27755 | RSS: Main: 182013952 03:45:23 INFO - PROCESS | 27755 | 03:45:25 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44792/tests/kraken/driver.html?testName=audio-fft) 03:45:26 INFO - PROCESS | 27755 | RSS: Main: 272752640 03:45:26 INFO - PROCESS | 27755 | 03:45:28 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44792/tests/kraken/driver.html?testName=audio-oscillator) 03:45:29 INFO - PROCESS | 27755 | RSS: Main: 178925568 03:45:29 INFO - PROCESS | 27755 | 03:45:31 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:32 INFO - PROCESS | 27755 | RSS: Main: 177348608 03:45:32 INFO - PROCESS | 27755 | 03:45:34 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44792/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:35 INFO - PROCESS | 27755 | RSS: Main: 212537344 03:45:35 INFO - PROCESS | 27755 | 03:45:38 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44792/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:39 INFO - PROCESS | 27755 | RSS: Main: 212918272 03:45:39 INFO - PROCESS | 27755 | 03:45:42 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44792/tests/kraken/driver.html?testName=json-parse-financial) 03:45:42 INFO - PROCESS | 27755 | RSS: Main: 212811776 03:45:42 INFO - PROCESS | 27755 | 03:45:44 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:44 INFO - PROCESS | 27755 | RSS: Main: 194007040 03:45:44 INFO - PROCESS | 27755 | 03:45:46 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:47 INFO - PROCESS | 27755 | RSS: Main: 195956736 03:45:47 INFO - PROCESS | 27755 | 03:45:49 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:49 INFO - PROCESS | 27755 | RSS: Main: 210735104 03:45:49 INFO - PROCESS | 27755 | 03:45:52 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:52 INFO - PROCESS | 27755 | RSS: Main: 214753280 03:45:52 INFO - PROCESS | 27755 | 03:45:55 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:56 INFO - PROCESS | 27755 | RSS: Main: 211312640 03:45:56 INFO - PROCESS | 27755 | 03:45:57 INFO - PROCESS | 27755 | Cycle 1(1): loaded http://localhost:44792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44792/tests/kraken/driver.html?testName=ai-astar) 03:45:58 INFO - PROCESS | 27755 | RSS: Main: 275206144 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | __start_tp_report 03:45:58 INFO - PROCESS | 27755 | _x_x_mozilla_page_load 03:45:58 INFO - PROCESS | 27755 | _x_x_mozilla_page_load_details 03:45:58 INFO - PROCESS | 27755 | |i|pagename|runs| 03:45:58 INFO - PROCESS | 27755 | |0;ai-astar;110;110;113;110;110;111;106;110;110;111 03:45:58 INFO - PROCESS | 27755 | |1;audio-beat-detection;155;126;157;171;128;158;160;129;187;125 03:45:58 INFO - PROCESS | 27755 | |2;audio-dft;161;161;160;162;162;160;162;159;161;159 03:45:58 INFO - PROCESS | 27755 | |3;audio-fft;76;76;77;167;77;75;76;76;165;75 03:45:58 INFO - PROCESS | 27755 | |4;audio-oscillator;90;92;162;91;92;100;152;92;93;156 03:45:58 INFO - PROCESS | 27755 | |5;imaging-gaussian-blur;116;116;116;117;116;116;117;117;118;117 03:45:58 INFO - PROCESS | 27755 | |6;imaging-darkroom;146;146;146;144;146;145;148;145;146;146 03:45:58 INFO - PROCESS | 27755 | |7;imaging-desaturate;94;94;95;94;94;95;94;94;94;95 03:45:58 INFO - PROCESS | 27755 | |8;json-parse-financial;56;56;55;55;54;55;57;75;55;55 03:45:58 INFO - PROCESS | 27755 | |9;json-stringify-tinderbox;58;59;58;58;58;58;57;57;58;57 03:45:58 INFO - PROCESS | 27755 | |10;stanford-crypto-aes;72;70;71;72;73;80;72;75;74;73 03:45:58 INFO - PROCESS | 27755 | |11;stanford-crypto-ccm;118;117;113;112;113;110;109;111;127;130 03:45:58 INFO - PROCESS | 27755 | |12;stanford-crypto-pbkdf2;157;161;154;156;159;158;156;160;157;157 03:45:58 INFO - PROCESS | 27755 | |13;stanford-crypto-sha256-iterative;63;67;66;64;64;64;71;66;64;62 03:45:58 INFO - PROCESS | 27755 | __end_tp_report 03:45:58 INFO - PROCESS | 27755 | __start_cc_report 03:45:58 INFO - PROCESS | 27755 | _x_x_mozilla_cycle_collect,1570 03:45:58 INFO - PROCESS | 27755 | __end_cc_report 03:45:58 INFO - PROCESS | 27755 | __startTimestamp1462790758008__endTimestamp 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | ------- Summary: start ------- 03:45:58 INFO - PROCESS | 27755 | Number of tests: 14 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:1.73 (1.6%) stddev-sans-first:1.83 03:45:58 INFO - PROCESS | 27755 | Values: 110.0 110.0 113.0 110.0 110.0 111.0 106.0 110.0 110.0 111.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:157.50 stddev:21.53 (13.7%) stddev-sans-first:22.75 03:45:58 INFO - PROCESS | 27755 | Values: 155.0 126.0 157.0 171.0 128.0 158.0 160.0 129.0 187.0 125.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 03:45:58 INFO - PROCESS | 27755 | Values: 161.0 161.0 160.0 162.0 162.0 160.0 162.0 159.0 161.0 159.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:37.96 (49.9%) stddev-sans-first:39.70 03:45:58 INFO - PROCESS | 27755 | Values: 76.0 76.0 77.0 167.0 77.0 75.0 76.0 76.0 165.0 75.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:91.50 stddev:31.03 (33.9%) stddev-sans-first:31.88 03:45:58 INFO - PROCESS | 27755 | Values: 90.0 92.0 162.0 91.0 92.0 100.0 152.0 92.0 93.0 156.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:45:58 INFO - PROCESS | 27755 | Values: 116.0 116.0 116.0 117.0 116.0 116.0 117.0 117.0 118.0 117.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 03:45:58 INFO - PROCESS | 27755 | Values: 146.0 146.0 146.0 144.0 146.0 145.0 148.0 145.0 146.0 146.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:45:58 INFO - PROCESS | 27755 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.50 stddev:6.27 (11.3%) stddev-sans-first:6.64 03:45:58 INFO - PROCESS | 27755 | Values: 56.0 56.0 55.0 55.0 54.0 55.0 57.0 75.0 55.0 55.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:45:58 INFO - PROCESS | 27755 | Values: 58.0 59.0 58.0 58.0 58.0 58.0 57.0 57.0 58.0 57.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:2.78 (3.8%) stddev-sans-first:2.92 03:45:58 INFO - PROCESS | 27755 | Values: 72.0 70.0 71.0 72.0 73.0 80.0 72.0 75.0 74.0 73.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:115.00 stddev:7.20 (6.3%) stddev-sans-first:7.60 03:45:58 INFO - PROCESS | 27755 | Values: 118.0 117.0 113.0 112.0 113.0 110.0 109.0 111.0 127.0 130.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:157.50 stddev:2.07 (1.3%) stddev-sans-first:2.19 03:45:58 INFO - PROCESS | 27755 | Values: 157.0 161.0 154.0 156.0 159.0 158.0 156.0 160.0 157.0 157.0 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - PROCESS | 27755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:2.56 (3.9%) stddev-sans-first:2.60 03:45:58 INFO - PROCESS | 27755 | Values: 63.0 67.0 66.0 64.0 64.0 64.0 71.0 66.0 64.0 62.0 03:45:58 INFO - PROCESS | 27755 | -------- Summary: end -------- 03:45:58 INFO - PROCESS | 27755 | 03:45:58 INFO - TEST-INFO | 27755: exit 0 03:45:58 INFO - TEST-OK | kraken | took 59951ms 03:45:58 INFO - SUITE-END | took 1172s 03:45:59 INFO - Completed test suite (00:19:32) 03:45:59 INFO - javascript benchmark 03:45:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.949675754864, 3385.881494147704, 3392.5420068290787, 3402.2174899773067, 3439.2605589798204, 5560.638558493695, 5563.527100196483, 5570.526505247059, 5577.86055348616, 5579.776808927638, 5554.805581804638, 5591.0, 5594.49649531542, 5602.663840169593, 5646.18130371097, 5003.849884503453, 5073.949260507394, 5117.104506711329, 5170.844874653748, 5213.556847667953, 5188.948110518903, 5235.973820130894, 5236.816711415101, 5238.816641417532, 5241.816536421226, 5106.336176297076, 5165.63840531163, 5184.585233181337, 5205.063088644042, 5211.088059589576, 5251.921221181667, 5268.9736551317, 5272.472752724735, 5281.947180528184, 5311.176767601028, 5013.047520971004, 5098.541131298164, 5173.275741396207, 5173.301604283449, 5182.093133701587, 5524.558035357162, 5583.246261754693, 5602.663840169562, 5607.214989901417, 5613.494785469327, 6089.117078023706, 6143.784967526115, 6144.662043587601, 6145.354737752561, 6147.969260153671, 6139.631622102688, 6183.350748171467, 6210.689465526705, 6213.56505044647, 6223.968880155616, 5762.394948530427, 5768.509676677488, 5774.653520788766, 5776.277965254343, 5779.017567013618, 6108.22065524731, 6272.319201995013, 6325.5255855811, 6330.968345158245, 6333.493320534346, 5896.793612223637, 5961.940380596138, 5966.940330596639, 5968.970155149196, 6008.939910600925, 6046.3651316612, 6047.758089676364, 6050.939490605126, 6053.0, 6053.424924632153, 5883.970580147157, 6017.548683848729, 6027.849303767353, 6032.306284777219, 6033.577649564489, 6083.969580152071, 6108.251008765781, 6109.34393638171, 6112.267354437867, 6138.969305153446, 4589.173948689201, 4620.653450991189, 4623.953760462352, 4625.583697467244, 4672.859814205579, 4075.9592404076175, 4087.4481944937647, 4157.958420415757, 4177.310743727251, 4183.309753890635, 5812.215350927655, 5820.592558520862, 5829.5336373090895, 5833.737481813244, 5834.620749651259, 6130.509559235251, 6159.84600384994, 6187.0, 6191.907121393183, 6192.81421557354, 5621.072523033654, 5680.971595141998, 5779.3642699303045, 5790.189373487715, 5815.5929084963645, 5262.368515778055, 5283.418823929364, 5284.603654725911, 5291.285676433632, 5296.3379577552805, 6375.872482550416, 6394.0, 6395.456386207132, 6398.648074355955, 6401.519886008568, 6063.757449701962, 6116.418940200763, 6124.496488522206, 6152.0, 6156.076588511759, 6332.366763323631, 6350.936490635035, 6353.555251132377, 6357.586756860789, 6362.204724409449, 5794.449527294901, 6017.097435384552, 6030.276366836008, 6031.75872965094, 6039.849003774765, 6117.694115294128, 6152.600080994721, 6187.597806142587, 6190.690465476618, 6191.102290167991, 6001.417264679211, 6007.369226231182, 6013.098035294741, 6017.3681763414215, 6051.848703782441, 5740.167675687086, 5833.125031245348, 5936.406359364029, 5988.820335389945, 6004.519638429003, 5812.593118481665, 5813.0, 5847.678377689098, 5851.824445266649, 5886.705664716833, 5951.761929522944, 5957.225560677084, 5971.253593300838, 5983.521318294439, 5992.250968628921, 5723.828285151452, 5765.91351129725, 5833.183354330482, 5858.736356863866, 5864.530837533072], "value": 5621.187537730235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.0574623698859, 660.207750699161, 661.2329697550836, 663.127986697493, 671.3085521912429, 33525.83237083814, 39879.0, 40614.39078413826, 40638.593614063815, 40749.388759168636, 42689.78655106728, 43209.567904320946, 43286.567134328645, 43290.567094329046, 43293.78353108238, 8135.186481351847, 8821.117888211193, 8976.865347019768, 9025.18773310402, 10405.583776648926, 10449.529771160316, 10598.258121931429, 10599.417032063233, 10604.0, 10609.84085238722, 10577.20670949678, 10615.946920265427, 10673.039426451618, 10683.83974240387, 10687.412192329419, 8441.07148213696, 8651.870221946676, 10517.368957862553, 10542.736431589234, 10680.51937662807, 10653.414062226575, 10776.78446431067, 10779.0, 10788.190885683527, 10806.081483073947, 39941.60058399408, 40527.59472405268, 40541.59458405407, 40553.391699124535, 40576.79711601423, 3926.469926559935, 4006.1186538961383, 4267.871963841089, 4340.565943405666, 4452.5547445255215, 33644.0, 34032.0, 34271.6572834271, 34502.137446563785, 34926.82536587301, 4418.094290670405, 4503.77548639485, 4521.231390663595, 4633.652476064275, 4666.813327466897, 267382.0, 268319.0, 269638.0, 270027.0, 270278.999999998, 39873.202535949116, 41600.79199603983, 64924.0, 65732.34267657358, 65743.67128164425, 33219.66780332214, 33435.0, 33492.0, 33506.0, 33556.49665255023, 16124.838751612568, 16309.102999334913, 16348.509544713677, 16361.754573681405, 16372.754408683879, 11232.66302010941, 13736.519221827188, 14010.229437380838, 14018.29908504591, 14049.71900561983, 9366.0, 9381.437113773196, 9400.435973841591, 9418.952905235567, 9490.762730931643, 3516.82415879205, 3629.2015756534047, 3642.2715456908722, 3663.7984910829628, 3668.5781135169264, 1088.967330980072, 1095.912327013837, 1159.2696601141226, 1162.0471213604762, 1179.7935361311736, 34509.13727156841, 34999.0, 35104.64895351065, 35181.120471988404, 35335.0, 1175.753091850721, 1196.0670676872053, 1237.3132911234352, 1243.4590952935503, 1269.3526301586073, 17540.561485962953, 17930.641387172185, 17992.460226193234, 18128.45614631563, 18194.52347438938, 495885.0, 500382.0, 503971.0, 504605.0, 506254.0, 62581.374186258465, 63233.0, 63252.05121923175, 63259.6837015812, 63341.0, 1401.70564181521, 1491.8065547561907, 1550.2636247782214, 1583.4299652125226, 1588.253520845224, 29375.559366609945, 32090.19774505656, 33031.33937321288, 33660.158496037795, 34075.0, 51460.74269628628, 51869.7406512965, 52155.73922130365, 52251.73874130605, 52277.0, 377109.0, 377294.0, 378795.0, 379235.0, 380224.0, 27446.5883011751, 30354.0, 30777.692223077484, 30881.536776948815, 31490.527642085846, 43637.12725745531, 43804.34293485536, 43916.78041609772, 44226.55773442353, 44465.55534444614, 37588.81205593955, 37714.622853772205, 37813.24373512459, 38078.8096059529, 38194.809025954695, 37006.074848129014, 37241.0, 37943.81028094842, 38211.61788382081, 38286.80856595699, 41620.375694364004, 42284.0, 42482.56555102783, 42876.78561607172, 42941.78529107334, 34767.65232347644, 35686.28627427385, 36438.8178059108, 36801.447978279815, 37110.44334335041, 27841.303967400978, 28138.644655780456, 28239.021192921064, 28325.858370708014, 28524.429511409242], "value": 19469.23269902889, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.90210349516127, 410.1939688512074, 415.93552999285123, 421.6247539689676, 421.7090207756648, 14737.336819843105, 18229.90356109048, 18992.240310387584, 19025.143868525916, 19075.427737167873, 16390.918045409755, 20286.18855245792, 20964.8951755241, 21184.0, 21273.57452850942, 5667.263255776754, 5819.738111784959, 5844.64932104073, 5867.1492633568105, 5879.11813228017, 4288.335308027261, 5704.942950570483, 5796.130580412951, 5989.490893274077, 6431.903521447182, 6347.873042539147, 6356.173697419329, 6386.0, 6388.7125079371535, 6390.808275751735, 6090.5736598438125, 6255.311915689271, 6269.937300627003, 6270.561060725751, 6335.651539165344, 5524.530414914737, 5525.834224973257, 5539.058360078796, 5545.3622833374275, 5577.9163312550345, 24148.39629009271, 25046.37384065413, 25504.617430738555, 25536.0, 25564.87217563919, 2416.903323867043, 2514.208024472285, 2551.1326149109204, 2556.6676332076713, 2655.49545586338, 14436.422543098264, 14524.273786310641, 14688.265586720621, 15065.472708455261, 15378.384864605403, 2022.5550378916614, 2063.8245749111343, 2113.4399384163207, 2132.5201829588373, 2163.8809865457392, 78445.21554784436, 78673.60663196705, 82786.0, 83297.58351208265, 83678.16321836825, 10393.960603939546, 10597.0, 10720.820709721924, 10778.083862871586, 10839.187060970458, 14612.561623151323, 14629.707405852036, 14674.0, 14695.77956330656, 14711.92644036773, 8166.714165004197, 8345.54099524532, 8384.832303353898, 8476.745697629081, 8476.872846907301, 6789.219239787389, 8372.874406883902, 8375.495215000677, 8415.579221038923, 8481.321494280442, 5982.312034116046, 6305.747770089237, 6322.178116844872, 6527.608343499405, 6549.541532092708, 1823.6535058338873, 1835.9265629374943, 1866.5986812835033, 1929.7684277886462, 1933.8162874526897, 1098.8681358236902, 1137.1414581990543, 1167.5988813423926, 1168.7253495428567, 1233.2600439736086, 20479.0, 20591.382258532267, 20830.79169208319, 21164.259250926145, 21500.78499214988, 1088.9618863339745, 1094.261373572851, 1103.3545375954996, 1151.4530597966066, 1191.8927296543352, 11699.824502632468, 11903.226290291102, 12132.15074944763, 12132.696682583006, 12157.027437804954, 503206.0, 518888.0, 520001.0, 539888.0, 547134.0, 77218.0, 93103.53448232716, 93413.0, 94997.52501237449, 96797.51601241948, 1097.1551905033239, 1128.638835572609, 1128.7516746315798, 1128.8081026225725, 1135.5628083188033, 18742.15660295317, 18984.0, 19000.619987600447, 19071.0, 19216.807831922062, 39714.801425992686, 40382.596174037884, 40406.39390409205, 41258.174836503706, 41259.587404125574, 55469.1679624814, 59385.703071484364, 59530.70234648799, 59844.40155598388, 59917.700411497666, 7075.398591119812, 8737.56312184401, 9014.414063085878, 9127.315451341308, 9410.29422793307, 13816.654583635489, 13853.861461385257, 14074.437022519394, 14758.704825903207, 14817.333220005341, 12495.312757798409, 12576.685582860502, 12739.044571657349, 13010.934945325213, 13137.540186093442, 12329.876701233232, 12763.48946042185, 12894.355282236038, 13029.15310504814, 13097.672558186121, 13018.804717929428, 13059.0, 13132.40904159296, 13168.683131686754, 13199.802002970155, 9160.358774885693, 9167.816643667224, 9209.815803684023, 9255.120763527455, 9375.8967711291, 12794.296313702836, 12834.0, 12853.586105528571, 12912.483500659868, 13020.739585208432], "value": 9842.239966414934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.702933869218, 1531.5022617649263, 1536.5697604670693, 1747.5893165106206, 1853.2957476159058, 8194.795130121742, 8427.494350338977, 8432.241098301152, 8449.155084491547, 8450.704225352114, 8205.22050405212, 8313.41806073575, 8330.375221858354, 8344.45761025533, 8395.496270223792, 2094.4030951178916, 2340.473393486469, 2398.436367453647, 2400.1239547565187, 2429.829911906167, 2375.489269806991, 2385.189035727852, 2388.128333158393, 2388.9641655375094, 2390.306811024801, 2327.674125622406, 2393.892274847636, 2396.1373905394044, 2396.376941995085, 2398.1486572266854, 2063.515073957619, 2387.3315471667875, 2441.011390386896, 2445.75542445754, 2447.9877600612062, 2289.8969546370286, 2345.835791494596, 2350.365401341628, 2352.4589344450874, 2385.6898603181476, 8371.95814020932, 8409.075001749803, 8433.578321083982, 8468.449550779242, 8471.618777155043, 5149.48505149482, 5248.422673505911, 5262.02652509287, 5265.842024739264, 5306.522412982811, 3332.616749073839, 3357.446021406465, 3416.26550291686, 3421.794692318469, 3424.7773894696766, 1038.8130136575414, 1059.348500672089, 1064.6273804168557, 1064.7072055184808, 1067.8167757287345, 12263.080268979862, 12281.263124212575, 12299.262044277282, 12323.815142772775, 12327.075469339745, 4662.53374662531, 4720.409948756405, 4760.143174228672, 4764.404449443819, 4817.445993710698, 10520.579176832995, 10526.368417894952, 10542.789144217073, 10546.367217966947, 10555.10281626055, 4878.926816097762, 5443.755031023614, 5444.646098003617, 5477.452254774491, 5495.065838807413, 4862.197737373293, 4959.628027897922, 4960.553550180501, 4963.503649635008, 4995.075910956485, 4116.238495878272, 4122.855700050483, 4180.226658068267, 4216.852410165691, 4225.492940847118, 1303.2571434282559, 1328.7908003716764, 1340.222670850904, 1340.443715857908, 1341.3092257487401, 948.3788118782209, 964.6286179820679, 1004.5228516454772, 1004.9397885231151, 1045.153425725165, 5999.730012149464, 6003.519718422515, 6046.606970546901, 6077.3314935357075, 6251.156093927261, 461.90069135136105, 470.33682507664713, 472.52983281634994, 476.48301592771537, 477.77305779755034, 4066.573009833925, 4199.0, 4221.029163292398, 4222.451081359403, 4230.61924426803, 10295.0, 10703.46482675863, 10728.570857165625, 10734.570617175226, 10736.0, 9821.361611495373, 10222.335548189343, 10430.26988110825, 10573.418461984511, 10595.682129536126, 7860.882086768703, 7929.246721561442, 7948.801279968047, 7976.641051152712, 8047.235512626291, 5781.4218578141845, 5969.582129250911, 5986.431289027535, 6017.428344307284, 6065.5754097212775, 9192.724218273463, 9247.39891907024, 9304.348695591243, 9429.245660347018, 9439.05609439078, 9581.856272155785, 9628.47043412619, 9666.95166524163, 9834.557444914853, 10129.189664826943, 7142.535735177197, 7148.142222933281, 7295.708171673074, 7387.7783666490095, 7402.074740657418, 7902.960485197767, 7916.960415197887, 7930.801729956797, 7961.6019199040975, 7966.0, 7166.820829479097, 7263.782086537412, 7322.487425880137, 7359.963200183965, 7363.631818408951, 7015.789526314219, 7065.258147894603, 7078.0, 7092.503524753218, 7171.1394632644415, 6617.503687223574, 6682.298358672464, 6685.699143538455, 6693.397594216543, 6693.598384096969, 4958.082754690394, 5020.748962551931, 5024.246363045572, 5044.848654540223, 5072.771725272445, 5068.847934561969, 5103.897922041612, 5109.821156259513, 5169.81905633301, 5268.710220937885], "value": 4506.621530903854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.70559435668395, 355.8149762123694, 356.54006331831937, 358.533905922301, 363.28795560701025, 6246.156768836206, 6249.156363890874, 6304.684765761716, 6350.364963503647, 6351.872962540758, 6267.968660156693, 6275.466585340251, 6292.528060395477, 6296.590721603104, 6309.526785491095, 4543.931841022379, 4700.083483720676, 4820.8071677132875, 4847.612191024709, 4850.490698476662, 4796.97601511992, 4822.782974766126, 4826.7586620669, 4836.6856154350035, 4852.514748525155, 4511.639068874499, 4801.327814106028, 4801.663883528155, 4802.927956080662, 4811.182099043153, 4605.4473463184295, 4621.260598304289, 4630.21286381316, 4700.106979673851, 4704.411948506437, 4115.218108559364, 4116.197341518405, 4123.36087906372, 4128.772917489537, 4140.441040459529, 5947.137665038588, 5950.0, 6007.969960150215, 6043.758249670008, 6049.304330002062, 5514.420985796514, 5529.30883639545, 5531.806386776484, 5533.474319939599, 5544.473275038865, 6405.391487808697, 6564.343565643445, 6566.409023187936, 6571.605703657796, 6575.769848055343, 4636.188666983265, 4638.0, 4638.072385522909, 4643.373144625466, 4651.790669419885, 6783.796486105425, 6890.793276201672, 6905.343992320722, 6915.619640919747, 6916.6541672916155, 4673.415823022122, 4704.85885423431, 4707.31743897133, 4710.081534100886, 4710.788014539354, 4765.594924431392, 4769.499202583748, 4773.856784296477, 4774.928376074362, 4775.474697783241, 5495.203195536625, 5495.53287970527, 5507.311586051744, 5509.118541033416, 5510.724463776875, 6474.0612611172055, 6643.638054198877, 6717.731290748316, 6720.092787473726, 6728.058071869942, 1682.0664531185064, 1693.5766058485378, 1701.5150682055803, 1701.5235733994502, 1701.6256423587038, 1119.6361182615683, 1120.3222050659397, 1130.4178348150708, 1132.3432409202642, 1140.9258398204256, 6278.30938596754, 6491.772787952399, 6643.800685979429, 6645.933540664628, 6659.800205993828, 6919.0, 6941.236463988957, 6945.722171113099, 6951.7914462566205, 6961.686724097428, 6559.180102487189, 6565.901511477332, 6568.310327415553, 6576.408123268929, 6581.703823327962, 3702.61122582125, 3743.989122936792, 3745.3071181831447, 3747.7563958343167, 3749.606291339425, 7007.1591409030225, 7176.425885929218, 7186.6047367395295, 7214.855702886018, 7242.927570724225, 7112.324329188718, 7122.430205583541, 7123.394511466583, 7133.179684336264, 7138.821529461805, 7232.0598322217775, 7252.311030452099, 7254.528455650471, 7263.3826124778925, 7269.418446524372, 6961.408280296231, 6964.233934267125, 6969.860602788017, 6972.093627828553, 6972.4073453757, 6731.32686731323, 6809.89785153233, 6858.074159988338, 6869.0383346330555, 6872.62200578973, 7228.49400541957, 7232.493725439169, 7235.746748863765, 7240.203577606564, 7250.709971601077, 4498.28027515609, 4524.547545245449, 4527.84152554659, 4531.320301954733, 4540.091981603627, 6874.621895795779, 6916.412104970933, 6928.445724342141, 6934.653267336714, 6935.653217339213, 6492.513061520499, 6693.531452798257, 6745.628990405575, 6764.154480689914, 6769.796906092825, 6716.529842910949, 6749.4600431964345, 6755.898661519983, 6761.188657361148, 6763.323667633197, 6621.966890165519, 6624.370684784938, 6627.37039981201, 6631.568948018364, 6634.734610615521, 6788.796336109727, 6803.625800581016, 6819.624920629413, 6832.965835170792, 6888.724451021903, 6440.2271727391135, 6581.243157037002, 6583.44040756541, 6587.176602924635, 6608.306127856506], "value": 5039.687613547873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.0721056364054, 824.4064273722921, 846.9239503944543, 902.2736696958946, 920.7283851263876, 15312.846871531281, 15548.45580404686, 15560.0, 15600.141992190425, 15611.297491612877, 14597.635059123528, 14600.342984565694, 14653.047551909118, 14670.119792812413, 14703.779443308358, 750.4296734481792, 763.0461922596754, 763.7594157840263, 764.2281295891162, 896.5830888636783, 887.5029983209391, 889.4396530186007, 890.0, 890.0120865838913, 890.2255038116815, 955.044955044955, 959.4627008875018, 961.5624890674726, 962.4129281138535, 962.4754508792724, 956.8469044952843, 958.7123862841155, 959.3811991265629, 959.5538074795219, 960.6493629825134, 582.3943099176851, 686.306830101601, 695.9443244540424, 697.0554898113035, 699.9440044796404, 15040.924795376062, 15078.095314281178, 15098.396064157421, 15126.621834454116, 15130.319135638923, 14330.140191588538, 14413.351399186957, 15075.924620376938, 15630.531084067496, 15912.0, 12017.51929922802, 12357.443915023845, 12380.276339205451, 12384.195027323196, 12625.0, 4080.367543030835, 4083.0, 4123.402106694542, 4149.087200815816, 4212.473440819897, 58656.41343586552, 58658.12012819768, 58837.82324353489, 59366.10950835741, 59379.0, 11449.626044874669, 11671.0, 11768.646940591796, 11831.585894493823, 12006.21959572625, 21884.343469695934, 21948.0, 22048.11807527713, 22051.11795528161, 22107.447313817283, 8294.294984926228, 8394.622241999125, 8510.78723031929, 8517.06312305646, 8744.387892847439, 5074.467180945948, 5097.082525145435, 5114.411842638145, 5149.6910185389, 5275.103232450492, 3427.5715535558056, 3492.336456073338, 3503.211777350076, 3504.649535046526, 3507.473878918183, 602.5842168903442, 609.9298580663192, 612.5773216480615, 628.4501061571125, 640.3436477610486, 635.5297080160648, 680.4556354916048, 700.6181631011111, 718.5832217313946, 725.8076609698434, 9503.0, 9815.165710914653, 9909.55407006672, 9958.15355694774, 9985.550650220757, 707.886738121898, 738.5863916206941, 753.333300029467, 759.2407592407592, 776.4293244465314, 4465.508794032654, 4539.682222244412, 4614.192516309699, 4698.060387922429, 4712.717236965793, 71272.64363678149, 71791.28208717846, 71909.2809071913, 72081.2791872085, 72495.0, 61581.0, 62483.99999999909, 63499.682501587195, 63541.0, 64449.0, 55253.447465525634, 55316.17025744617, 56545.71727141338, 57370.13944790832, 57596.0, 8756.605952732016, 8817.559122043744, 8819.294456443597, 9060.954695226745, 9146.862797058182, 35939.64060359363, 37375.252494950495, 37521.437178441796, 37810.0, 38190.80904595459, 45817.77091114523, 46230.537694622624, 47220.527794722984, 49971.250431242835, 50201.49798501968, 11580.247283926517, 11659.358735269641, 11763.823542646696, 11837.171398002401, 12258.0, 12096.153269271066, 12201.938990304992, 12301.815472767737, 12552.372381381078, 12592.370381481072, 10587.947060264649, 12029.278243305429, 12112.939435302767, 12259.264444133381, 12383.442745076673, 12416.317102559085, 12861.228326300452, 13146.21122732639, 13281.60155195307, 13415.262160581262, 12785.36073196318, 12793.0, 12945.805812912626, 13004.869951300745, 13070.934645326712, 10932.672019839418, 10993.175511836484, 11045.889541104487, 11047.72380690489, 11051.281666691639, 10575.841362379724, 10707.357558546511, 10867.13062954946, 11143.275687080313, 11219.158563107636], "value": 7115.080975303775, "unit": "score"}], "name": "dromaeo_css", "value": 7472.352065768833, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 113.0, 110.0, 110.0, 111.0, 106.0, 110.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 157.0, 171.0, 128.0, 158.0, 160.0, 129.0, 187.0, 125.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 162.0, 160.0, 162.0, 159.0, 161.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 167.0, 77.0, 75.0, 76.0, 76.0, 165.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 162.0, 91.0, 92.0, 100.0, 152.0, 92.0, 93.0, 156.0], "value": 112.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 144.0, 146.0, 145.0, 148.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 54.0, 55.0, 57.0, 75.0, 55.0, 55.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 71.0, 72.0, 73.0, 80.0, 72.0, 75.0, 74.0, 73.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 113.0, 112.0, 113.0, 110.0, 109.0, 111.0, 127.0, 130.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 161.0, 154.0, 156.0, 159.0, 158.0, 156.0, 160.0, 157.0, 157.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 66.0, 64.0, 64.0, 64.0, 71.0, 66.0, 64.0, 62.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1509.9999999999998, "alertThreshold": 2.0}]} 03:45:59 INFO - Return code: 0 03:45:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:45:59 ERROR - # TBPL SUCCESS # 03:45:59 INFO - Running post-action listener: _resource_record_post_action 03:45:59 INFO - Running post-run listener: _resource_record_post_run 03:46:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 498851840; Read time: 16; Write time: 374888 03:46:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 248418304; Read time: 0; Write time: 202244 03:46:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 250433536; Read time: 16; Write time: 172644 03:46:00 INFO - Running post-run listener: _upload_blobber_files 03:46:00 INFO - Blob upload gear active. 03:46:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:46:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:01 INFO - (blobuploader) - INFO - Done attempting. 03:46:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:02 INFO - (blobuploader) - INFO - Done attempting. 03:46:02 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:02 INFO - Return code: 0 03:46:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dd14814fa0b3b443c88920e8cff24eb3391a8ba308d0369f9b8a5c2cc23bd586da5d3d9ad998029a6b4107cd6ad25551a89d13b17e564fc6b3c571df28936eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6abbcaaca5a3dd9a0f19dcb9039806b025a9263d71927169a0b01e382d2af5f53322e8375ffca550e398be2cdf68ba7c856e00543ddb1f960b8e8e14f3623d41"} 03:46:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:02 INFO - Contents: 03:46:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dd14814fa0b3b443c88920e8cff24eb3391a8ba308d0369f9b8a5c2cc23bd586da5d3d9ad998029a6b4107cd6ad25551a89d13b17e564fc6b3c571df28936eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6abbcaaca5a3dd9a0f19dcb9039806b025a9263d71927169a0b01e382d2af5f53322e8375ffca550e398be2cdf68ba7c856e00543ddb1f960b8e8e14f3623d41"} 03:46:02 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:02 INFO - Copying logs to upload dir... 03:46:02 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.015447 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-09 03:46:02.182444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 03:46:02.186327) ========= 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=4300f881736b422476174874000001bc-1462789534.211480-881536595 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-Aurora/sha512/4dd14814fa0b3b443c88920e8cff24eb3391a8ba308d0369f9b8a5c2cc23bd586da5d3d9ad998029a6b4107cd6ad25551a89d13b17e564fc6b3c571df28936eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6abbcaaca5a3dd9a0f19dcb9039806b025a9263d71927169a0b01e382d2af5f53322e8375ffca550e398be2cdf68ba7c856e00543ddb1f960b8e8e14f3623d41"} build_url:https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/bzVX6XKhQRKZScLjtNqtoA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4dd14814fa0b3b443c88920e8cff24eb3391a8ba308d0369f9b8a5c2cc23bd586da5d3d9ad998029a6b4107cd6ad25551a89d13b17e564fc6b3c571df28936eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6abbcaaca5a3dd9a0f19dcb9039806b025a9263d71927169a0b01e382d2af5f53322e8375ffca550e398be2cdf68ba7c856e00543ddb1f960b8e8e14f3623d41"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 03:46:02.213671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:46:02.214191) ========= 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=4300f881736b422476174874000001bc-1462789534.211480-881536595 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 03:46:02.300108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 03:46:02.300629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 03:46:02.301135) ========= ========= Total master_lag: 0.18 =========