builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1469447221.17 results: success (0) buildid: 20160725015529 builduid: 7e02ace4dd9847cab657ff55c8b108f3 revision: 59caf5ec41614bf5de43d45f41a1decee29a869d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.169455) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.169932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.170238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.185910) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.186314) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-25 04:47:02-- 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% 67.2M=0s 2016-07-25 04:47:02 (67.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.312694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.313007) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016118 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.361971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:01.362334) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59caf5ec41614bf5de43d45f41a1decee29a869d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59caf5ec41614bf5de43d45f41a1decee29a869d --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=82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-25 04:47:02,853 truncating revision to first 12 chars 2016-07-25 04:47:02,854 Setting DEBUG logging. 2016-07-25 04:47:02,854 attempt 1/10 2016-07-25 04:47:02,854 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/59caf5ec4161?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 04:47:03,175 unpacking tar archive at: mozilla-beta-59caf5ec4161/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:02.018031) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:02.018363) ========= script_repo_revision: 59caf5ec41614bf5de43d45f41a1decee29a869d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:02.018760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:02.019021) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:47:02.030074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-25 04:47:02.030487) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:47:03 INFO - MultiFileLogger online at 20160725 04:47:03 in /builds/slave/test 04:47:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:47:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:47:03 INFO - {'append_to_log': False, 04:47:03 INFO - 'base_work_dir': '/builds/slave/test', 04:47:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:47:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:47:03 INFO - 'branch': 'Mozilla-Beta', 04:47:03 INFO - 'buildbot_json_path': 'buildprops.json', 04:47:03 INFO - 'config_files': ('talos/linux_config.py',), 04:47:03 INFO - 'default_actions': ('clobber', 04:47:03 INFO - 'read-buildbot-config', 04:47:03 INFO - 'download-and-extract', 04:47:03 INFO - 'populate-webroot', 04:47:03 INFO - 'create-virtualenv', 04:47:03 INFO - 'install', 04:47:03 INFO - 'run-tests'), 04:47:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:47:03 INFO - 'download_minidump_stackwalk': True, 04:47:03 INFO - 'download_symbols': 'ondemand', 04:47:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:47:03 INFO - 'tooltool.py': '/tools/tooltool.py', 04:47:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:47:03 INFO - '/tools/misc-python/virtualenv.py')}, 04:47:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:47:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:47:03 INFO - 'installer_path': 'installer.exe', 04:47:03 INFO - 'log_level': 'info', 04:47:03 INFO - 'log_name': 'talos', 04:47:03 INFO - 'log_to_console': True, 04:47:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:47:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:47:03 INFO - 'opt_config_files': (), 04:47:03 INFO - 'pip_index': False, 04:47:03 INFO - 'sps_profile': False, 04:47:03 INFO - 'sps_profile_interval': 0, 04:47:03 INFO - 'suite': 'dromaeojs', 04:47:03 INFO - 'system_bits': '32', 04:47:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:47:03 INFO - 'title': 'talos-linux64-ix-066', 04:47:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:47:03 INFO - 'use_talos_json': True, 04:47:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:47:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:47:03 INFO - 'work_dir': 'build'} 04:47:03 INFO - ##### 04:47:03 INFO - ##### Running clobber step. 04:47:03 INFO - ##### 04:47:03 INFO - Running pre-action listener: _resource_record_pre_action 04:47:03 INFO - Running main action method: clobber 04:47:03 INFO - rmtree: /builds/slave/test/build 04:47:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:47:04 INFO - Running post-action listener: _resource_record_post_action 04:47:04 INFO - ##### 04:47:04 INFO - ##### Running read-buildbot-config step. 04:47:04 INFO - ##### 04:47:04 INFO - Running pre-action listener: _resource_record_pre_action 04:47:04 INFO - Running main action method: read_buildbot_config 04:47:04 INFO - Using buildbot properties: 04:47:04 INFO - { 04:47:04 INFO - "project": "", 04:47:04 INFO - "product": "firefox", 04:47:04 INFO - "script_repo_revision": "production", 04:47:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:47:04 INFO - "repository": "", 04:47:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:47:04 INFO - "buildid": "20160725015529", 04:47:04 INFO - "pgo_build": "True", 04:47:04 INFO - "basedir": "/builds/slave/test", 04:47:04 INFO - "buildnumber": 111, 04:47:04 INFO - "slavename": "talos-linux64-ix-066", 04:47:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:47:04 INFO - "platform": "ubuntu64_hw", 04:47:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:47:04 INFO - "branch": "mozilla-beta", 04:47:04 INFO - "repo_path": "releases/mozilla-beta", 04:47:04 INFO - "revision": "59caf5ec41614bf5de43d45f41a1decee29a869d", 04:47:04 INFO - "stage_platform": "linux64-pgo", 04:47:04 INFO - "builduid": "7e02ace4dd9847cab657ff55c8b108f3", 04:47:04 INFO - "slavebuilddir": "test" 04:47:04 INFO - } 04:47:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 04:47:04 INFO - Running post-action listener: _resource_record_post_action 04:47:04 INFO - ##### 04:47:04 INFO - ##### Running download-and-extract step. 04:47:04 INFO - ##### 04:47:04 INFO - Running pre-action listener: _resource_record_pre_action 04:47:04 INFO - Running main action method: download_and_extract 04:47:04 INFO - mkdir: /builds/slave/test/build/tests 04:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:04 INFO - https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:47:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:47:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:47:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:47:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:47:07 INFO - Downloaded 1327 bytes. 04:47:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:47:07 INFO - Using the following test package requirements: 04:47:07 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:47:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:47:07 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:47:07 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'jsshell-linux-x86_64.zip'], 04:47:07 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:47:07 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:47:07 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:47:07 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:47:07 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:47:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:47:07 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:47:07 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:47:07 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')]} 04:47:07 INFO - https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:47:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:47:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:47:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:47:09 INFO - Downloaded 24200543 bytes. 04:47:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:47:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:47:11 INFO - Return code: 0 04:47:11 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:11 INFO - https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:47:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:47:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:47:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:47:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:47:26 INFO - Downloaded 24200543 bytes. 04:47:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:47:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:47:27 INFO - Return code: 0 04:47:27 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')]} 04:47:27 INFO - https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:47:29 INFO - Downloaded 10840145 bytes. 04:47:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:47:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:47:29 INFO - Return code: 0 04:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:29 INFO - https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:47:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:47:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:47:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:47:31 INFO - Downloaded 56025200 bytes. 04:47:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:47:31 INFO - mkdir: /builds/slave/test/properties 04:47:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:47:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:47:31 INFO - Contents: 04:47:31 INFO - build_url:https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:47:32 INFO - Running post-action listener: _resource_record_post_action 04:47:32 INFO - Running post-action listener: set_extra_try_arguments 04:47:32 INFO - ##### 04:47:32 INFO - ##### Running populate-webroot step. 04:47:32 INFO - ##### 04:47:32 INFO - Running pre-action listener: _resource_record_pre_action 04:47:32 INFO - Running main action method: populate_webroot 04:47:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:47:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:47:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:47:32 INFO - '--tppagecycles', 04:47:32 INFO - '7'], 04:47:32 INFO - 'tests': ['tsvgm']}}, 04:47:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:47:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:47:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:47:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:47:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:47:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['damp', 'tps']}, 04:47:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'tests': ['damp', 'tps']}, 04:47:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['dromaeo_dom']}, 04:47:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:47:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['a11yr', 04:47:32 INFO - 'ts_paint', 04:47:32 INFO - 'tpaint', 04:47:32 INFO - 'sessionrestore', 04:47:32 INFO - 'sessionrestore_no_auto_restore', 04:47:32 INFO - 'tabpaint']}, 04:47:32 INFO - 'other-e10s': {'tests': ['a11yr', 04:47:32 INFO - 'ts_paint', 04:47:32 INFO - 'tpaint', 04:47:32 INFO - 'sessionrestore', 04:47:32 INFO - 'sessionrestore_no_auto_restore', 04:47:32 INFO - 'tabpaint']}, 04:47:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:47:32 INFO - 'ts_paint', 04:47:32 INFO - 'tpaint', 04:47:32 INFO - 'sessionrestore', 04:47:32 INFO - 'sessionrestore_no_auto_restore', 04:47:32 INFO - 'tabpaint']}, 04:47:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:47:32 INFO - 'ts_paint', 04:47:32 INFO - 'tpaint', 04:47:32 INFO - 'sessionrestore', 04:47:32 INFO - 'sessionrestore_no_auto_restore', 04:47:32 INFO - 'tabpaint']}, 04:47:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['a11yr', 04:47:32 INFO - 'ts_paint', 04:47:32 INFO - 'tpaint', 04:47:32 INFO - 'sessionrestore', 04:47:32 INFO - 'sessionrestore_no_auto_restore', 04:47:32 INFO - 'tabpaint']}, 04:47:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['a11yr', 04:47:32 INFO - 'ts_paint', 04:47:32 INFO - 'tpaint', 04:47:32 INFO - 'sessionrestore', 04:47:32 INFO - 'sessionrestore_no_auto_restore', 04:47:32 INFO - 'tabpaint']}, 04:47:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['tsvgx', 04:47:32 INFO - 'tsvgr_opacity', 04:47:32 INFO - 'tart', 04:47:32 INFO - 'tscrollx', 04:47:32 INFO - 'cart']}, 04:47:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:47:32 INFO - 'tsvgr_opacity', 04:47:32 INFO - 'tart', 04:47:32 INFO - 'tscrollx', 04:47:32 INFO - 'cart']}, 04:47:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'talos_options': ['--disable-e10s'], 04:47:32 INFO - 'tests': ['tp5o']}, 04:47:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'tests': ['tp5o']}, 04:47:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'talos_options': ['--disable-e10s', 04:47:32 INFO - '--xperf_path', 04:47:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:32 INFO - 'tests': ['tp5n']}, 04:47:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:47:32 INFO - 'talos_options': ['--xperf_path', 04:47:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:47:32 INFO - 'tests': ['tp5n']}}, 04:47:32 INFO - 'talos.zip': {'path': '', 04:47:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:47:32 INFO - Running post-action listener: _resource_record_post_action 04:47:32 INFO - ##### 04:47:32 INFO - ##### Running create-virtualenv step. 04:47:32 INFO - ##### 04:47:32 INFO - Running pre-action listener: _resource_record_pre_action 04:47:32 INFO - Running main action method: create_virtualenv 04:47:32 INFO - Creating virtualenv /builds/slave/test/build/venv 04:47:32 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 04:47:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:47:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:47:32 INFO - Using real prefix '/usr' 04:47:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:47:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:35 INFO - Installing pip.................done. 04:47:35 INFO - Return code: 0 04:47:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:35 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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:35 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 04:47:35 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 04:47:35 INFO - Using env: {'DISPLAY': ':0', 04:47:35 INFO - 'HOME': '/home/cltbld', 04:47:35 INFO - 'LANG': 'en_US.UTF-8', 04:47:35 INFO - 'LANGUAGE': 'en_US:en', 04:47:35 INFO - 'LOGNAME': 'cltbld', 04:47:35 INFO - 'MAIL': '/var/mail/cltbld', 04:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:35 INFO - 'MOZ_NO_REMOTE': '1', 04:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:35 INFO - 'NO_EM_RESTART': '1', 04:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:35 INFO - 'PWD': '/builds/slave/test', 04:47:35 INFO - 'SHELL': '/bin/bash', 04:47:35 INFO - 'SHLVL': '1', 04:47:35 INFO - 'TERM': 'linux', 04:47:35 INFO - 'TMOUT': '86400', 04:47:35 INFO - 'USER': 'cltbld', 04:47:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:35 INFO - '_': '/tools/buildbot/bin/python'} 04:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:35 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 04:47:35 INFO - Cleaning up... 04:47:35 INFO - Return code: 0 04:47:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:35 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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:35 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 04:47:35 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 04:47:35 INFO - Using env: {'DISPLAY': ':0', 04:47:35 INFO - 'HOME': '/home/cltbld', 04:47:35 INFO - 'LANG': 'en_US.UTF-8', 04:47:35 INFO - 'LANGUAGE': 'en_US:en', 04:47:35 INFO - 'LOGNAME': 'cltbld', 04:47:35 INFO - 'MAIL': '/var/mail/cltbld', 04:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:35 INFO - 'MOZ_NO_REMOTE': '1', 04:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:35 INFO - 'NO_EM_RESTART': '1', 04:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:35 INFO - 'PWD': '/builds/slave/test', 04:47:35 INFO - 'SHELL': '/bin/bash', 04:47:35 INFO - 'SHLVL': '1', 04:47:35 INFO - 'TERM': 'linux', 04:47:35 INFO - 'TMOUT': '86400', 04:47:35 INFO - 'USER': 'cltbld', 04:47:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:35 INFO - '_': '/tools/buildbot/bin/python'} 04:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:35 INFO - Downloading/unpacking psutil>=0.7.1 04:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:37 INFO - Installing collected packages: psutil 04:47:37 INFO - Running setup.py install for psutil 04:47:37 INFO - building 'psutil._psutil_linux' extension 04:47:37 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 04:47:37 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 04:47:37 INFO - building 'psutil._psutil_posix' extension 04:47:37 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 04:47:37 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 04:47:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:37 INFO - Successfully installed psutil 04:47:37 INFO - Cleaning up... 04:47:38 INFO - Return code: 0 04:47:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:38 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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:38 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 04:47:38 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 04:47:38 INFO - Using env: {'DISPLAY': ':0', 04:47:38 INFO - 'HOME': '/home/cltbld', 04:47:38 INFO - 'LANG': 'en_US.UTF-8', 04:47:38 INFO - 'LANGUAGE': 'en_US:en', 04:47:38 INFO - 'LOGNAME': 'cltbld', 04:47:38 INFO - 'MAIL': '/var/mail/cltbld', 04:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:38 INFO - 'MOZ_NO_REMOTE': '1', 04:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:38 INFO - 'NO_EM_RESTART': '1', 04:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:38 INFO - 'PWD': '/builds/slave/test', 04:47:38 INFO - 'SHELL': '/bin/bash', 04:47:38 INFO - 'SHLVL': '1', 04:47:38 INFO - 'TERM': 'linux', 04:47:38 INFO - 'TMOUT': '86400', 04:47:38 INFO - 'USER': 'cltbld', 04:47:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:38 INFO - '_': '/tools/buildbot/bin/python'} 04:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:47:38 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 04:47:38 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 04:47:38 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 04:47:38 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 04:47:38 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 04:47:38 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 04:47:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:47:40 INFO - Installing collected packages: mozsystemmonitor 04:47:40 INFO - Running setup.py install for mozsystemmonitor 04:47:40 INFO - Successfully installed mozsystemmonitor 04:47:40 INFO - Cleaning up... 04:47:40 INFO - Return code: 0 04:47:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:40 INFO - Using env: {'DISPLAY': ':0', 04:47:40 INFO - 'HOME': '/home/cltbld', 04:47:40 INFO - 'LANG': 'en_US.UTF-8', 04:47:40 INFO - 'LANGUAGE': 'en_US:en', 04:47:40 INFO - 'LOGNAME': 'cltbld', 04:47:40 INFO - 'MAIL': '/var/mail/cltbld', 04:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:40 INFO - 'MOZ_NO_REMOTE': '1', 04:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:40 INFO - 'NO_EM_RESTART': '1', 04:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:40 INFO - 'PWD': '/builds/slave/test', 04:47:40 INFO - 'SHELL': '/bin/bash', 04:47:40 INFO - 'SHLVL': '1', 04:47:40 INFO - 'TERM': 'linux', 04:47:40 INFO - 'TMOUT': '86400', 04:47:40 INFO - 'USER': 'cltbld', 04:47:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:40 INFO - '_': '/tools/buildbot/bin/python'} 04:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:40 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:42 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 04:47:42 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 04:47:42 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 04:47:42 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 04:47:42 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 04:47:42 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 04:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:42 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 04:47:42 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 04:47:42 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 04:47:42 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 04:47:42 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 04:47:42 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 04:47:43 INFO - Downloading docopt-0.6.1.tar.gz 04:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:43 INFO - Running setup.py install for blobuploader 04:47:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:43 INFO - Running setup.py install for requests 04:47:43 INFO - Running setup.py install for docopt 04:47:43 INFO - Successfully installed blobuploader requests docopt 04:47:43 INFO - Cleaning up... 04:47:43 INFO - Return code: 0 04:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:43 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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:43 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 04:47:43 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 04:47:43 INFO - Using env: {'DISPLAY': ':0', 04:47:43 INFO - 'HOME': '/home/cltbld', 04:47:43 INFO - 'LANG': 'en_US.UTF-8', 04:47:43 INFO - 'LANGUAGE': 'en_US:en', 04:47:43 INFO - 'LOGNAME': 'cltbld', 04:47:43 INFO - 'MAIL': '/var/mail/cltbld', 04:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:43 INFO - 'MOZ_NO_REMOTE': '1', 04:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:43 INFO - 'NO_EM_RESTART': '1', 04:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:43 INFO - 'PWD': '/builds/slave/test', 04:47:43 INFO - 'SHELL': '/bin/bash', 04:47:43 INFO - 'SHLVL': '1', 04:47:43 INFO - 'TERM': 'linux', 04:47:43 INFO - 'TMOUT': '86400', 04:47:43 INFO - 'USER': 'cltbld', 04:47:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:43 INFO - '_': '/tools/buildbot/bin/python'} 04:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:44 INFO - Running setup.py (path:/tmp/pip-TLqtGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:44 INFO - Running setup.py (path:/tmp/pip-VfQ2Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:44 INFO - Running setup.py (path:/tmp/pip-O0w4Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:44 INFO - Running setup.py (path:/tmp/pip-ttOcRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:44 INFO - Running setup.py (path:/tmp/pip-SRPBff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:44 INFO - Running setup.py (path:/tmp/pip-xvEbuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:44 INFO - Running setup.py (path:/tmp/pip-rZ6jii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:44 INFO - Running setup.py (path:/tmp/pip-PnSOqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:44 INFO - Running setup.py (path:/tmp/pip-rjaj7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:44 INFO - Running setup.py (path:/tmp/pip-giwjQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:44 INFO - Running setup.py (path:/tmp/pip-T6rbMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:44 INFO - Running setup.py (path:/tmp/pip-Z8O5NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:44 INFO - Running setup.py (path:/tmp/pip-M2KqJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:45 INFO - Running setup.py (path:/tmp/pip-vYmQdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:45 INFO - Running setup.py (path:/tmp/pip-XvoK4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:45 INFO - Running setup.py (path:/tmp/pip-ok860i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:45 INFO - Running setup.py (path:/tmp/pip-rBgSI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:45 INFO - Running setup.py install for manifestparser 04:47:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:45 INFO - Running setup.py install for mozcrash 04:47:45 INFO - Running setup.py install for mozdebug 04:47:45 INFO - Running setup.py install for mozdevice 04:47:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:45 INFO - Running setup.py install for mozfile 04:47:45 INFO - Running setup.py install for mozhttpd 04:47:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:45 INFO - Running setup.py install for mozinfo 04:47:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Running setup.py install for mozInstall 04:47:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Running setup.py install for mozleak 04:47:46 INFO - Running setup.py install for mozlog 04:47:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Running setup.py install for moznetwork 04:47:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Running setup.py install for mozprocess 04:47:46 INFO - Running setup.py install for mozprofile 04:47:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Running setup.py install for mozrunner 04:47:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:46 INFO - Running setup.py install for mozscreenshot 04:47:46 INFO - Running setup.py install for moztest 04:47:46 INFO - Running setup.py install for mozversion 04:47:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:47 INFO - Cleaning up... 04:47:47 INFO - Return code: 0 04:47:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:47 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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:47 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 04:47:47 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 04:47:47 INFO - Using env: {'DISPLAY': ':0', 04:47:47 INFO - 'HOME': '/home/cltbld', 04:47:47 INFO - 'LANG': 'en_US.UTF-8', 04:47:47 INFO - 'LANGUAGE': 'en_US:en', 04:47:47 INFO - 'LOGNAME': 'cltbld', 04:47:47 INFO - 'MAIL': '/var/mail/cltbld', 04:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:47 INFO - 'MOZ_NO_REMOTE': '1', 04:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:47 INFO - 'NO_EM_RESTART': '1', 04:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:47 INFO - 'PWD': '/builds/slave/test', 04:47:47 INFO - 'SHELL': '/bin/bash', 04:47:47 INFO - 'SHLVL': '1', 04:47:47 INFO - 'TERM': 'linux', 04:47:47 INFO - 'TMOUT': '86400', 04:47:47 INFO - 'USER': 'cltbld', 04:47:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:47 INFO - '_': '/tools/buildbot/bin/python'} 04:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:47 INFO - Running setup.py (path:/tmp/pip-CO9OyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:47 INFO - Running setup.py (path:/tmp/pip-XiKy2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:47 INFO - Running setup.py (path:/tmp/pip-6PdUrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:47 INFO - Running setup.py (path:/tmp/pip-Ccdkwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:47 INFO - Running setup.py (path:/tmp/pip-XnPFxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:47 INFO - Running setup.py (path:/tmp/pip-llUecR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:47 INFO - Running setup.py (path:/tmp/pip-zKVrkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:47 INFO - Running setup.py (path:/tmp/pip-46KEJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:47 INFO - Running setup.py (path:/tmp/pip-tEfmho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:47 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)) 04:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:47 INFO - Running setup.py (path:/tmp/pip-vzuiZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:48 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)) 04:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:48 INFO - Running setup.py (path:/tmp/pip-5OXXsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:48 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)) 04:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:48 INFO - Running setup.py (path:/tmp/pip-8m0dqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:48 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)) 04:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:48 INFO - Running setup.py (path:/tmp/pip-47XLbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:48 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)) 04:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:48 INFO - Running setup.py (path:/tmp/pip-VIGWQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:48 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)) 04:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:48 INFO - Running setup.py (path:/tmp/pip-a2gLfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:48 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)) 04:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:48 INFO - Running setup.py (path:/tmp/pip-NZT0Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:48 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)) 04:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:48 INFO - Running setup.py (path:/tmp/pip-9gXgsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:48 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)) 04:47:48 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)) 04:47:48 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)) 04:47:48 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)) 04:47:48 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)) 04:47:48 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)) 04:47:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:50 INFO - Downloading blessings-1.6.tar.gz 04:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:50 INFO - Installing collected packages: blessings 04:47:50 INFO - Running setup.py install for blessings 04:47:50 INFO - Successfully installed blessings 04:47:50 INFO - Cleaning up... 04:47:50 INFO - Return code: 0 04:47:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:50 INFO - Reading from file tmpfile_stdout 04:47:50 INFO - Current package versions: 04:47:50 INFO - argparse == 1.2.1 04:47:50 INFO - blessings == 1.6 04:47:50 INFO - blobuploader == 1.2.4 04:47:50 INFO - docopt == 0.6.1 04:47:50 INFO - manifestparser == 1.1 04:47:50 INFO - mozInstall == 1.12 04:47:50 INFO - mozcrash == 0.17 04:47:50 INFO - mozdebug == 0.1 04:47:50 INFO - mozdevice == 0.48 04:47:50 INFO - mozfile == 1.2 04:47:50 INFO - mozhttpd == 0.7 04:47:50 INFO - mozinfo == 0.9 04:47:50 INFO - mozleak == 0.1 04:47:50 INFO - mozlog == 3.1 04:47:50 INFO - moznetwork == 0.27 04:47:50 INFO - mozprocess == 0.22 04:47:50 INFO - mozprofile == 0.28 04:47:50 INFO - mozrunner == 6.11 04:47:50 INFO - mozscreenshot == 0.1 04:47:50 INFO - mozsystemmonitor == 0.0 04:47:50 INFO - moztest == 0.7 04:47:50 INFO - mozversion == 1.4 04:47:50 INFO - psutil == 3.1.1 04:47:50 INFO - requests == 1.2.3 04:47:50 INFO - wsgiref == 0.1.2 04:47:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:50 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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:50 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 04:47:50 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 04:47:50 INFO - Using env: {'DISPLAY': ':0', 04:47:50 INFO - 'HOME': '/home/cltbld', 04:47:50 INFO - 'LANG': 'en_US.UTF-8', 04:47:50 INFO - 'LANGUAGE': 'en_US:en', 04:47:50 INFO - 'LOGNAME': 'cltbld', 04:47:50 INFO - 'MAIL': '/var/mail/cltbld', 04:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:50 INFO - 'MOZ_NO_REMOTE': '1', 04:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:50 INFO - 'NO_EM_RESTART': '1', 04:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:50 INFO - 'PWD': '/builds/slave/test', 04:47:50 INFO - 'SHELL': '/bin/bash', 04:47:50 INFO - 'SHLVL': '1', 04:47:50 INFO - 'TERM': 'linux', 04:47:50 INFO - 'TMOUT': '86400', 04:47:50 INFO - 'USER': 'cltbld', 04:47:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:50 INFO - '_': '/tools/buildbot/bin/python'} 04:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 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)) 04:47:51 INFO - Cleaning up... 04:47:51 INFO - Return code: 0 04:47:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:51 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 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47:51 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 04:47:51 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 04:47:51 INFO - Using env: {'DISPLAY': ':0', 04:47:51 INFO - 'HOME': '/home/cltbld', 04:47:51 INFO - 'LANG': 'en_US.UTF-8', 04:47:51 INFO - 'LANGUAGE': 'en_US:en', 04:47:51 INFO - 'LOGNAME': 'cltbld', 04:47:51 INFO - 'MAIL': '/var/mail/cltbld', 04:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:51 INFO - 'MOZ_NO_REMOTE': '1', 04:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:51 INFO - 'NO_EM_RESTART': '1', 04:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:51 INFO - 'PWD': '/builds/slave/test', 04:47:51 INFO - 'SHELL': '/bin/bash', 04:47:51 INFO - 'SHLVL': '1', 04:47:51 INFO - 'TERM': 'linux', 04:47:51 INFO - 'TMOUT': '86400', 04:47:51 INFO - 'USER': 'cltbld', 04:47:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:51 INFO - '_': '/tools/buildbot/bin/python'} 04:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:51 INFO - Downloading/unpacking jsonschema 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:53 INFO - Downloading/unpacking functools32 (from jsonschema) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:53 INFO - warning: no files found matching '*.txt' 04:47:53 INFO - no previously-included directories found matching 'build' 04:47:53 INFO - no previously-included directories found matching 'dist' 04:47:53 INFO - no previously-included directories found matching '.git*' 04:47:53 INFO - Installing collected packages: jsonschema, functools32 04:47:53 INFO - Running setup.py install for functools32 04:47:53 INFO - warning: no files found matching '*.txt' 04:47:53 INFO - no previously-included directories found matching 'build' 04:47:53 INFO - no previously-included directories found matching 'dist' 04:47:53 INFO - no previously-included directories found matching '.git*' 04:47:53 INFO - Successfully installed jsonschema functools32 04:47:53 INFO - Cleaning up... 04:47:53 INFO - Return code: 0 04:47:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3d67dccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', '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 04:47: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', 'flake8'] in /builds/slave/test/build 04:47: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 flake8 04:47:53 INFO - Using env: {'DISPLAY': ':0', 04:47:53 INFO - 'HOME': '/home/cltbld', 04:47:53 INFO - 'LANG': 'en_US.UTF-8', 04:47:53 INFO - 'LANGUAGE': 'en_US:en', 04:47:53 INFO - 'LOGNAME': 'cltbld', 04:47:53 INFO - 'MAIL': '/var/mail/cltbld', 04:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:53 INFO - 'MOZ_NO_REMOTE': '1', 04:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:53 INFO - 'NO_EM_RESTART': '1', 04:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:53 INFO - 'PWD': '/builds/slave/test', 04:47:53 INFO - 'SHELL': '/bin/bash', 04:47:53 INFO - 'SHLVL': '1', 04:47:53 INFO - 'TERM': 'linux', 04:47:53 INFO - 'TMOUT': '86400', 04:47:53 INFO - 'USER': 'cltbld', 04:47:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:53 INFO - '_': '/tools/buildbot/bin/python'} 04:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:53 INFO - Downloading/unpacking flake8 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:47:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:47:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:47:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:56 INFO - no previously-included directories found matching 'docs/_build' 04:47:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:47:56 INFO - Running setup.py install for pep8 04:47:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:56 INFO - no previously-included directories found matching 'docs/_build' 04:47:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:47:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:47:56 INFO - Cleaning up... 04:47:56 INFO - Return code: 0 04:47:56 INFO - Running post-action listener: _resource_record_post_action 04:47:56 INFO - Running post-action listener: _start_resource_monitoring 04:47:56 INFO - Starting resource monitoring. 04:47:56 INFO - ##### 04:47:56 INFO - ##### Running install step. 04:47:56 INFO - ##### 04:47:56 INFO - Running pre-action listener: _resource_record_pre_action 04:47:56 INFO - Running main action method: install 04:47:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:57 INFO - Reading from file tmpfile_stdout 04:47:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:57 INFO - Reading from file tmpfile_stdout 04:47:57 INFO - Output received: 04:47:57 INFO - Usage: mozinstall [options] installer 04:47:57 INFO - Options: 04:47:57 INFO - -h, --help show this help message and exit 04:47:57 INFO - -d DEST, --destination=DEST 04:47:57 INFO - Directory to install application into. [default: 04:47:57 INFO - "/builds/slave/test"] 04:47:57 INFO - --app=APP Application being installed. [default: firefox] 04:47:57 INFO - mkdir: /builds/slave/test/build/application 04:47:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:48:10 INFO - Reading from file tmpfile_stdout 04:48:10 INFO - Output received: 04:48:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:48:10 INFO - Running post-action listener: _resource_record_post_action 04:48:10 INFO - ##### 04:48:10 INFO - ##### Running run-tests step. 04:48:10 INFO - ##### 04:48:10 INFO - Running pre-action listener: _resource_record_pre_action 04:48:10 INFO - Running main action method: run_tests 04:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:48:10 INFO - Python 2.7.3 04:48:10 INFO - Return code: 0 04:48:10 INFO - grabbing minidump binary from tooltool 04:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:48:10 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 0x233b410>, '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 0x233c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x233c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:48:10 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 04:48:10 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 04:48:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:48:10 INFO - Return code: 0 04:48:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:48:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:48:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:48:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:48:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:48:11 INFO - Return code: 0 04:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 04:48:11 INFO - Using env: {'DISPLAY': ':0', 04:48:11 INFO - 'HOME': '/home/cltbld', 04:48:11 INFO - 'LANG': 'en_US.UTF-8', 04:48:11 INFO - 'LANGUAGE': 'en_US:en', 04:48:11 INFO - 'LOGNAME': 'cltbld', 04:48:11 INFO - 'MAIL': '/var/mail/cltbld', 04:48:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:48:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:11 INFO - 'MOZ_NO_REMOTE': '1', 04:48:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:11 INFO - 'NO_EM_RESTART': '1', 04:48:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:11 INFO - 'PWD': '/builds/slave/test', 04:48:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:48:11 INFO - 'SHELL': '/bin/bash', 04:48:11 INFO - 'SHLVL': '1', 04:48:11 INFO - 'TERM': 'linux', 04:48:11 INFO - 'TMOUT': '86400', 04:48:11 INFO - 'USER': 'cltbld', 04:48:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617', 04:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:11 INFO - '_': '/tools/buildbot/bin/python'} 04:48:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:48:11 INFO - mozversion application_buildid: 20160725015529 04:48:11 INFO - mozversion application_changeset: 59caf5ec41614bf5de43d45f41a1decee29a869d 04:48:11 INFO - mozversion application_display_name: Firefox 04:48:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:48:11 INFO - mozversion application_name: Firefox 04:48:11 INFO - mozversion application_remotingname: firefox 04:48:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:48:11 INFO - mozversion application_vendor: Mozilla 04:48:11 INFO - mozversion application_version: 48.0 04:48:11 INFO - mozversion platform_buildid: 20160725015529 04:48:11 INFO - mozversion platform_changeset: 59caf5ec41614bf5de43d45f41a1decee29a869d 04:48:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:48:11 INFO - mozversion platform_version: 48.0 04:48:11 INFO - using testdate: 1469447291 04:48:11 INFO - actual date: 1469447291 04:48:11 INFO - starting webserver on 'localhost:59011' 04:48:11 INFO - SUITE-START | Running 2 tests 04:48:11 INFO - TEST-START | dromaeo_css 04:48:11 INFO - operating with platform_type : linux_ 04:48:11 INFO - Initialising browser for dromaeo_css test... 04:48:11 INFO - TEST-INFO | started process 1557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5uaW9O/profile http://localhost:59011/getInfo.html) 04:48:15 INFO - PROCESS | 1557 | __metrics Screen width/height:1600/1200 04:48:15 INFO - PROCESS | 1557 | colorDepth:24 04:48:15 INFO - PROCESS | 1557 | Browser inner width/height: 1024/697 04:48:15 INFO - PROCESS | 1557 | __metrics 04:48:16 INFO - PROCESS | 1557 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:48:16 ERROR - PROCESS | 1557 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:48:17 INFO - TEST-INFO | 1557: exit 0 04:48:17 INFO - Browser initialized. 04:48:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:48:17 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5uaW9O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:29 INFO - PROCESS | 1653 | RSS: Main: 139636736 04:48:29 INFO - PROCESS | 1653 | 04:49:20 INFO - PROCESS | 1653 | 1469447360573 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] 04:51:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:59011/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59011/tests/dromaeo/cssquery-ext.html) 04:51:29 INFO - PROCESS | 1653 | RSS: Main: 249589760 04:51:29 INFO - PROCESS | 1653 | 04:54:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:59011/tests/dromaeo/cssquery-ext.html (next: http://localhost:59011/tests/dromaeo/cssquery-jquery.html) 04:54:31 INFO - PROCESS | 1653 | RSS: Main: 219394048 04:54:31 INFO - PROCESS | 1653 | 04:57:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:59011/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59011/tests/dromaeo/cssquery-mootools.html) 04:57:34 INFO - PROCESS | 1653 | RSS: Main: 218165248 04:57:34 INFO - PROCESS | 1653 | 05:00:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:59011/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59011/tests/dromaeo/cssquery-prototype.html) 05:00:36 INFO - PROCESS | 1653 | RSS: Main: 211972096 05:00:36 INFO - PROCESS | 1653 | 05:03:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:59011/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59011/tests/dromaeo/cssquery-yui.html) 05:03:39 INFO - PROCESS | 1653 | RSS: Main: 209633280 05:03:39 INFO - PROCESS | 1653 | 05:06:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:59011/tests/dromaeo/cssquery-yui.html (next: http://localhost:59011/tests/dromaeo/cssquery-dojo.html) 05:06:42 INFO - PROCESS | 1653 | RSS: Main: 256942080 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | __start_tp_report 05:06:42 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 05:06:42 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 05:06:42 INFO - PROCESS | 1653 | |i|pagename|runs| 05:06:42 INFO - PROCESS | 1653 | |0;dojo.html;3304.801711897286;3364.276680513689;3370.140614143393;3393.406153923063;3407.4548072308435;5460.945390546093;5466.125419932801;5479.342478902532;5483.780648774049;5493.725313734317;5401;5488.4237155098635;5505.229267902497;5516.117421212607;5531.308586426697;4849.660523763338;4959.03298856724;5067.214581739836;5113.923291150636;5147.639665223436;4914.926276105862;4988.725620090893;5023.974880125595;5024.120778863702;5032.295478632995;4951.0592987332475;5023.673461225027;5086.237064440345;5112.41207261166;5116.258142569325;5070.61970352225;5081.161608334621;5094.439611642716;5097.158968770148;5116.1814109742445;4903.4606193318705;4906.190478571068;4987.501249875019;4998.650094493387;5006.249062640597;5382.91925621116;5400.135978243462;5431.83704488866;5432.049391356536;5444;5836.474717275423;5877.353491115974;5879.088741245114;5880.353161152269;5880.9411905880825;5791.044477661181;5835.737391817378;5890.528757699374;5893.764249430018;5944.940550594482;5501.944980550184;5514.944850551483;5548.4174161713245;5553.861153471155;5557.305336832896;5810.767569297265;6011.939880601138;6029;6038.698065096728;6047.365026672224;5718.7426565804635;5824.796132135355;5826.970865145732;5836.037053886062;5838.766449341979;5868.2077919480325;5872.941270587325;5881.529477641779;5882.205902203234;5887.175795388649;5691.060974939089;5695.40198279183;5828.417158284223;5834.708264586754;5841.766329346863;5823.505002074787;5855.677937713466;5861.531077513789;5864.70676466175;5896.204012458349;4515.412996310459;4540.909181816345;4542.545745425497;4545.3863728396245;4571.337156112345;4023.5775243599587;4028.295048366524;4068.1253530490494;4098.672106231495;4111.301078816608;5529.142982837667;5544.944550554524;5558.583106266965;5581.860453488695;5588;5831.795887144014;5833.620814647034;5834.3290521589715;5835.299764028344;5839.445252700986;5506.449355064542;5553.444655534414;5571.192177134293;5628.493435590816;5635.859103522363;5062.088824011713;5104.668196567285;5119.744012799345;5127.359080114986;5133.25567792668;6174.629522228591;6193.969030154821;6195.96902015487;6198.2252218472695;6204.627722336674;5774.989376859033;5816.76732930678;5889.087191485327;5910.52715782745;5911.497522710618;6170.845728856814;6202.317745048132;6202.937970620416;6212.751489940532;6219.813405597839;5642.266505354278;5826.417358264309;5836.678982655994;5836.824895253149;5859.296884373903;5831.7375718091935;5863.941360586339;5888.087346461305;5892.646441213541;5924.8815023700145;5713.542916566747;5728.971355143198;5753.654780713171;5757.4242575743765;5757.65454072757;5601;5689.118186681071;5732.742026608729;5747.856303592276;5754.079347304411;5605.5515558756015;5610.270664813711;5610.635308704921;5614.6631202128;5662.122371032497;5706.572007099401;5710;5710.400407957105;5718.942810572007;5721.399253078534;5567.220589117445;5609.21470994053;5623.971880140573;5645.040343141593;5728.283964504437 05:06:42 INFO - PROCESS | 1653 | |1;ext.html;660.3198705333508;670.3932940688677;673.5924765516862;739.956661107838;744.4007573903012;33045.83477082614;33765.83117084414;41128;41819.372709409385;41860;43210.78394608023;43569.7821510892;43728.781356093175;43771.3434298485;43860.78069609655;8581.957090214555;8858.955705221464;8860.689875854347;8871.201591856732;8871.95564022179;8765.342599305046;8925.553722313858;8935.910640893606;8943.95528022359;8947.373683842134;9133.95433022834;9178.54107294636;9186.908130918671;9208.953955230214;9215.078492150798;9087.182153606174;9128.863067053999;9164.266858651292;9169.95415022924;9172.266218702554;9010.324225683034;9103.908960910372;9116.498592577405;9119.179273865384;9119.316051296179;43797.12405751867;44287.11425771499;44343;44364;44407.11185776299;3800.182960663443;3988.4615576897036;4157.08544120293;4247.426597409341;4487.955120448786;33770;33917.49123763145;34136.82931585326;34333.484997725056;35235.647643523494;4459.353393757887;4555.385023021883;4575.428071491064;4580.358749775034;4591.058832939239;219339;219901;222804;298324;298347;39493.40759888604;60577;60928;61004.38995610076;61005.694971524856;38059.61940380616;38146.618533814304;38270.80864595659;38280.80859595684;38293.617063829006;16986.660266794843;17261.223244954006;17262.309507619553;17269.050202238745;17273.309067637154;14480.203588802717;14529.491467798576;14532.346044428026;14573.344199510835;14573.635659108608;9106.453612783254;9199.356045076915;9244.306676999118;9278.118578735144;9342.766430839147;3508.122969257686;3525.1539630488496;3545.7695249809194;3571.589267234301;3640.3265395901844;1049.611643691839;1096.7641956979287;1195.1574140231116;1236.0605939485877;1267.9683007924875;33482.3303533928;33529.66470335314;34150.14624634404;34323.31353372918;34868.65131348705;1219.2379762648345;1222.908281878845;1238.5726924211133;1246.2771592476342;1254.1534464236604;18090.819091809175;18161.818381816014;18258.807080618233;19270.421887343404;19291.710624340645;491716;493865;494972;495202;502274;63581.682091589246;64038;64119.358806411336;64120.35879641144;64256;1401.509471684902;1410.7742761158165;1524.8780097592166;1539.4688832352597;1556.8754499640002;30226.670181704616;30284.84857575698;33010.504842426904;33178.33643327168;33322.83338583291;51652;51884.74057629688;52308.21537677014;52433.73783131212;52456.737716311174;408420;409933;410382;411083;411143;26703.19890403291;29618;30279.848600756854;30457;30609.387812244076;43507.78246108749;43578;43753.78123109364;44513.55486445094;44544.331835021854;37365.4395184067;37529.249415011;37858.81070594629;39591.208175835745;40921.79539102285;38723.22553548857;40171;40217.39673904952;40817.77546673604;40890.38664420095;40756;40932.795336023126;41334.1733165341;41519.37720934128;41669.37495937624;35333;38897.80551097226;39571.40642890416;40023.1995360097;40231;26586.601200981615;26926;27155.04957326484;28360.983270876648;28457.28856778597 05:06:42 INFO - PROCESS | 1653 | |2;jquery.html;416.68956627312656;426.66506792168144;427.4315160836088;437.20647025648447;438.44755607934;17921.910390448047;18491;18503.16735746893;18749;19634.84016758159;17968.460946171603;18716.25134994602;18786.248550058015;20019.699704504445;20367.49081272965;5069.797208111671;5198.3761948566225;5211.739413029352;5475.06923822951;5750.971245143789;5547.55619550435;5711.114777209518;5717.885642287151;5727.713614319288;5737.741801618937;5638.802641907534;5683;5688.061469857468;5688.971555142219;5715.942840571583;5525.364583072937;5657.434256574351;5678.517326027292;5728.455796699307;5740.339860915986;5051.292819005305;5162.819301324435;5164.2770012198325;5181.093308670967;5271.156614941629;13384.19694818314;14004.859951400458;22583.77416225833;23324.76675233243;23398;2400.4838959623767;2425.8787060646896;2459.237636332725;2764.087851009162;2859.1565488180827;9686.806263874754;10602.469876506144;10749.83875241872;10753.623623173151;14647.70704585913;2038.9286374976805;2077.02379881457;2089.341857314941;2099.548597051641;2144.2280778919576;79130.60434697848;79144.60427697882;79467.20532794714;79768;80482.59758701228;11433.742288348276;11457.541698331974;11592.942035289938;11684.591039313584;11765.823512647317;16414.26135823891;16442;16666.250018749186;16713.415030473876;16734;8353.582320883932;8469.872951905727;8691.739247822576;8798.736037918872;8818.691345802994;8498.065212826585;8513.063563008063;8535.061143274235;8555.743327700178;8630.482171069756;4804.591609713214;4906.092372911023;4958.479359667255;4980.203167493184;5002.599272203789;1947.8149575790278;1987.2448469581466;2008.116428771336;2016.939491815248;2051.4563640634947;1066.5787014129376;1125.611663975927;1131.7340425000118;1135.1769966774023;1140.4262118276724;18795;18847.811521884607;19135;19550.8044919549;19552.413427597196;1054.4569546683465;1075.8224892892586;1088.820344643125;1108.4457771114444;1115.4422788605698;10692.411917344622;11039.779204415867;11067.944660276808;11284;11335.263207891461;559090;563069;565599;570491;580385;85783;95274;100326.49836750915;103140.48429757803;103298;1103.8178700514486;1111.1333160135107;1122.5004872831512;1128.841962125303;1137.9487923043482;17216.22526986314;17750.644987100444;17812.91093544524;17852.10739462996;17989.64020719552;40379.19241615092;40467.190656186125;40556.59443405528;41133;41166.79416602898;52658;53847.73076134594;53998.460015399345;57022.7148864253;59569.404305958116;8890.511021893857;8908.465492070496;9050.773730656787;9203.86194207074;9215.216706580015;12743.426545805276;13537.255450950292;13687.247201404018;13920.721585568435;13995.930020349833;11585;11590.478428470908;11605.767884642091;11722.238054526428;11895.76208475843;11317.547298107984;11603.12976526747;11643.59247426336;11738.647840564796;11783;11214.943925280322;12131.514739410324;12184.75630487403;12388.194767340094;12485.87514124847;9096.226820720312;9168.358214925158;9266.53667316618;9288.489133097744;9376.67181648639;9362.391444556082;12128;12159;12438.129330946747;12462.688432789253 05:06:42 INFO - PROCESS | 1653 | |3;mootools.html;1285.395863943946;1328.136711137761;1336.131514515565;1431.2056808471293;1495.3420494982213;8108;8219.71231006915;8277.130901255372;8312.335013198937;8322.542260175687;8383;8535.445196062252;8545.487270763759;8583.098774628668;8616.138386161381;2407.7471865454136;2419.6491508731224;2438.6951631046118;2440.036185706645;2442.255112190781;2412.6984126984125;2449.5590793657134;2462.261321603512;2465.642481840132;2472.7279999200073;2394.0902457066377;2402.9639555406684;2407.9518409631796;2428.611422172453;2440.8413453125577;2344.120954642009;2415.3961509622595;2425.9514809703796;2446.681931348931;2449.2652204338715;2355.6819829323163;2430.4409985703387;2443.218170185541;2445.2664200739705;2447.2535876557645;7555.848883022309;8309.709160179365;8844.911550884473;8870.955645221797;8891.777705557413;5132.897342053138;5281.683099014072;5290.60320475962;5293.7617807198385;5294.232336311214;3321.7840840345543;3329.350776598564;3377.206356506219;3540.964590354115;3594.514740510024;1119.4067144413473;1120.3781901044918;1130.0789856267115;1133.3766428464312;1156.6587856582328;12399.442025108892;12458.12793104483;12494.687632809162;12542.874571254262;12561.371931403484;4504.864854054384;4567.703099298601;4648.3259927310355;4652.813887444532;4664.300354946718;10664.520096595672;10695.251332406813;10699.572017119384;10703.571857125784;10717.196210284104;5369.355677318668;5378.91931621026;5380.381256155514;5384.40771515133;5384.596155288369;4932.53140951609;4935.802567897315;4938.851834444972;4940.407151141886;4941.160002799533;3725.3666876631037;3746.3631182699005;3769.095417099876;3825.617438256152;3835.1562656215588;1121.5457739615306;1132.898039176478;1136.181948996721;1149.816029435303;1150.6893138852463;1082.7455547946226;1098.5001824170142;1106.8948449897248;1109.2623405435456;1113.9275947063416;6021.458068773832;6157.384261573897;6189.659568723763;6195.690215489208;6201.503879689614;1015.5125539740818;1017.5217647705566;1025.031345378625;1052.9105026072716;1068.5992752717732;4209.97895010523;4220.092680073799;4223.577642235752;4239.364095385655;4243.766592837362;10416.427096509764;10802.405867677353;10847;10937.507812148473;10955.671329860117;10724.03483686472;10779.245452818228;10907.618233361794;11074.390908499949;11080.722981925355;8016.759497215093;8219.054808696957;8401.243888049983;8507.191816777397;8521.701740439055;5824.807483487924;5903.409659034062;5921.289445266596;5992.700364981821;6195.597286176384;9342.159205671522;9771.462569558742;9834;9946.602135914482;10063.345882517613;9885.258605604464;9902.504874756378;9945.502724863873;10093.19254459656;10122.848157277795;7921.603919803872;7975.601219939096;8012.078610959814;8042.437029407885;8050.838983220186;8156.510609363457;8327.250547450758;8443.493390396596;8536.786580335542;8546.401751877309;7671.194524574839;7761.72833950809;7772.222777722182;7781.688732450639;7809.140994490488;7636.08366995964;7642.7325043623205;7676.884846727416;7727.227277272453;7789.922100779147;7087.291270872872;7123.074000379917;7153.928460715326;7160.785176444715;7167.104111986002;4492.842750503717;5191.091558977239;5311.415744268204;5468;5486.31421072366;5315.123004704181;5322.441143680013;5366.302380690485;5382.085045542189;5403.351597808288 05:06:42 INFO - PROCESS | 1653 | |4;prototype.html;358.74887578694904;358.92821435712864;361.8389816531643;366.12861389892055;366.8862652577701;6075;6083.817485475432;6083.939160608393;6109.9999999999945;6110.480609148228;6064.06007068905;6065.787697430591;6066.484348830344;6098.237720284965;6101.87796244076;4484.686071974963;4590.40324757781;4656.6274698024245;4665.790039448216;4669.159551280768;4653.092646933849;4672.836450724225;4675.298705194231;4691.366665500165;4714.033623107255;4482.97758511207;4647.674662773607;4673.369095172142;4677.9064418711605;4681.368015317923;4574.2909848973295;4632;4687.039156972846;4695.389599352063;4697.271922851946;4139.19285739281;4152.335626299778;4153.231652144333;4161.313383291784;4161.854335098287;5837.299524057098;5856.5314774818335;5858.853528661775;5862.589618726691;5867.354590994987;5423.810166644149;5433.755481003364;5434.673919564799;5436.21174929633;5437.211604317391;6351.523635727339;6354.078658594524;6354.4281014708895;6364.172657554488;6364.204474440695;4340.696151269412;4446.244138496463;4469.7988590513505;4481.551844815525;4485.663575231838;6547.3125321841;6649.5012874034155;6652.068710380599;6656.434203092743;6667.399934005963;4551.931721024187;4563.406757121553;4563.9087218255445;4567.269236922143;4567.497575266718;4616.699914505546;4623.676342656049;4625.722456652612;4626.699264547794;4634.397528321297;5306.177542480922;5306.28365170697;5324.653897496651;5325.946740532545;5330.653507521999;6233.906491402633;6396.936030639634;6410.262819775786;6428.260750013715;6430.77492287777;1601.719699052661;1618.360747504729;1623.4967160180381;1629.5030015845043;1629.576310159367;1012.6152062216458;1068.5031460370965;1071.346478648024;1077.0844781935448;1083.534080345459;6112.297085835097;6123.510119190454;6130.049842274366;6142.170806941006;6172.135900973867;6481.125048118443;6483.870322593616;6493.545451818327;6504.869902601921;6510.283868774431;6160.537959653044;6164.815055548341;6172.9074063889075;6177.505799536116;6194.163787888578;3476.1483436558206;3484.7386446016144;3503.211777350076;3512.069301635018;3514.789112653249;6827.556208846409;6871.725130994704;7019.89470157948;7020.087388639547;7033.4724895633035;6726.7981960541265;6745;6796.490263230277;6837.076994605664;6878.312168783182;6987.6855541499735;6989.231184569693;6997.300269973064;6999.055127557816;7004.824879378057;6591.769288074895;6602.9009564855605;6604.438622716931;6610.933890661032;6635.303293154149;6424.196975378078;6534.542582019213;6557.147570815763;6569.441597464269;6577.835554111186;6918.411934985583;6927.44580433554;6954.582725036514;6962.23415424313;6971.965140174267;4560.4071470708595;4583.854036490878;4589.862304130881;4600.332951722048;4602;6601.405873471411;6606.306337834458;6608.70260838273;6617.602943823386;6625.370589793962;6250.49996000328;6426.485881129592;6432.195975503062;6435.839104022437;6437.742490300336;6388.9041664374145;6421.903671444838;6422.807315780347;6425.967870160619;6435.549511534147;6303.936960630518;6304.968475157595;6311.90532142009;6317.684115794284;6326.620402775849;6441.774537891151;6448.967755161194;6453.386928241809;6465.579737317059;6519.576227545194;6024.186734790923;6158.507319414346;6197.783077592263;6327.303996560283;6336.493080553637 05:06:42 INFO - PROCESS | 1653 | |5;yui.html;840.848647243496;857.8198578298557;901.1439132823818;917.4266083697689;924.4083786376721;14823.332950017248;14981.775273370908;15028.549143525697;15049.172295523742;15067.17130557819;12809.10336276461;12839.614811555668;12929.418176182071;12942.158759680615;12956.80564791529;750.7635094945075;881.964721411146;897.0984160918268;904.6200595749801;914.3919293669702;907.2741806554762;910.7040211931115;911.4166933162782;912.6030176873048;913.0458670689146;956.3783540698532;962.1484985787558;962.9277804164681;963.388248462228;963.3930623707055;791.6239786101585;941.6515889121035;951.8952915179325;953.4755884263627;960.5149399553251;690.8894576867727;698.8322802527408;699.9685014174374;700.2927043685863;700.7967689370076;14568.927155364261;14592.270386480739;14616;14653.780193297109;14658.926705366512;14304.499342523066;14318.92840535801;14450.927745361207;14572.05281656689;14677.706445871023;11954.10344224178;11960.40197990097;12084.335361555111;12237.265764054186;12327.630171094881;4055.959440405588;4071.348584226539;4078.7144899856726;4118.4440100586335;4225;53246.467535324926;53292.93414131695;53560.73219633916;53640.73179634116;53671;10595;10940.671779846618;10963.232573719763;11150.275232109887;11233.550657973752;19910.50223744389;19949;20113.19547218095;20141.194352225746;20213.898930505253;8820;9018.413803102778;9153.450792952444;9158.908410915805;9199.264058875275;5136.640435169502;5143.871403214949;5178.533931946067;5213.530782229617;5238.869028274324;3474.965250347515;3531.099569609733;3535.487354333607;3537.6816086552335;3538.433850583894;593.8871614393252;657.4444594317794;665.9567128136656;667.5927684112687;677.7289084366195;696.6899729620371;709.4359983812881;724.6811402982671;814.2061490047275;832.3798769916451;9913.959544153851;10175.907480911526;10197.011478233075;10226.767896095103;10230.700089883123;741.5365396627108;767.7082708570707;807.0678366486717;845.8731190321502;847.1909326593088;4666.300054991711;4687.6249900007915;4785.473597904228;4799.712017278975;4817.759112044454;60769;60902.69548652317;61559;62255.64210505221;62297.68851155806;52530.47469525256;53480;53868.73065634725;54413;54646.453535464934;48047.5195248043;48140.518594813606;48242.03515929732;48580.75709621429;48634.27048594274;9176.001991535972;9363.531823408666;9403.952980235055;9426.151646351587;9441.811163776823;35592.644073558935;37750.62249377471;38912.2217555653;39108.41337379999;39129.804350979204;46145.76927115343;47491.762541187076;47838.5216147848;48551.51448485611;48983.755081224364;12730.936345318214;12906.870931290567;13093;13106.868931310564;13337.799933000819;13975.440982360999;14201.502947396792;14254.714905702036;14323.355449005028;14496;13263.469461221443;13412.32938353098;13514.39185236647;13571;13732.519361822688;13766.174029558259;13796.17222966585;13850;13863.4454621814;13939.303034848013;13203.141795783244;13443.260620665957;13454.730905382034;13490.865091349353;13965.720685586028;11259.605913792979;11389.316641001566;11468.369239691563;11511.654650360502;11721.589744358907;11027.283226590567;11053.447327633747;11287.43562821872;11340.489677964346;11381.43092845338 05:06:42 INFO - PROCESS | 1653 | __end_tp_report 05:06:42 INFO - PROCESS | 1653 | __start_cc_report 05:06:42 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,826 05:06:42 INFO - PROCESS | 1653 | __end_cc_report 05:06:42 INFO - PROCESS | 1653 | __startTimestamp1469448402006__endTimestamp 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | ------- Summary: start ------- 05:06:42 INFO - PROCESS | 1653 | Number of tests: 6 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5470.37 Median:5635.86 stddev:590.66 (10.5%) stddev-sans-first:567.51 05:06:42 INFO - PROCESS | 1653 | Values: 3304.8 3364.3 3370.1 3393.4 3407.5 5460.9 5466.1 5479.3 5483.8 5493.7 5401.0 5488.4 5505.2 5516.1 5531.3 4849.7 4959.0 5067.2 5113.9 5147.6 4914.9 4988.7 5024.0 5024.1 5032.3 4951.1 5023.7 5086.2 5112.4 5116.3 5070.6 5081.2 5094.4 5097.2 5116.2 4903.5 4906.2 4987.5 4998.7 5006.2 5382.9 5400.1 5431.8 5432.0 5444.0 5836.5 5877.4 5879.1 5880.4 5880.9 5791.0 5835.7 5890.5 5893.8 5944.9 5501.9 5514.9 5548.4 5553.9 5557.3 5810.8 6011.9 6029.0 6038.7 6047.4 5718.7 5824.8 5827.0 5836.0 5838.8 5868.2 5872.9 5881.5 5882.2 5887.2 5691.1 5695.4 5828.4 5834.7 5841.8 5823.5 5855.7 5861.5 5864.7 5896.2 4515.4 4540.9 4542.5 4545.4 4571.3 4023.6 4028.3 4068.1 4098.7 4111.3 5529.1 5544.9 5558.6 5581.9 5588.0 5831.8 5833.6 5834.3 5835.3 5839.4 5506.4 5553.4 5571.2 5628.5 5635.9 5062.1 5104.7 5119.7 5127.4 5133.3 6174.6 6194.0 6196.0 6198.2 6204.6 5775.0 5816.8 5889.1 5910.5 5911.5 6170.8 6202.3 6202.9 6212.8 6219.8 5642.3 5826.4 5836.7 5836.8 5859.3 5831.7 5863.9 5888.1 5892.6 5924.9 5713.5 5729.0 5753.7 5757.4 5757.7 5601.0 5689.1 5732.7 5747.9 5754.1 5605.6 5610.3 5610.6 5614.7 5662.1 5706.6 5710.0 5710.4 5718.9 5721.4 5567.2 5609.2 5624.0 5645.0 5728.3 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:54903.32 Median:40906.09 stddev:105934.92 (259.0%) stddev-sans-first:106153.81 05:06:42 INFO - PROCESS | 1653 | Values: 660.3 670.4 673.6 740.0 744.4 33045.8 33765.8 41128.0 41819.4 41860.0 43210.8 43569.8 43728.8 43771.3 43860.8 8582.0 8859.0 8860.7 8871.2 8872.0 8765.3 8925.6 8935.9 8944.0 8947.4 9134.0 9178.5 9186.9 9209.0 9215.1 9087.2 9128.9 9164.3 9170.0 9172.3 9010.3 9103.9 9116.5 9119.2 9119.3 43797.1 44287.1 44343.0 44364.0 44407.1 3800.2 3988.5 4157.1 4247.4 4488.0 33770.0 33917.5 34136.8 34333.5 35235.6 4459.4 4555.4 4575.4 4580.4 4591.1 219339.0 219901.0 222804.0 298324.0 298347.0 39493.4 60577.0 60928.0 61004.4 61005.7 38059.6 38146.6 38270.8 38280.8 38293.6 16986.7 17261.2 17262.3 17269.1 17273.3 14480.2 14529.5 14532.3 14573.3 14573.6 9106.5 9199.4 9244.3 9278.1 9342.8 3508.1 3525.2 3545.8 3571.6 3640.3 1049.6 1096.8 1195.2 1236.1 1268.0 33482.3 33529.7 34150.1 34323.3 34868.7 1219.2 1222.9 1238.6 1246.3 1254.2 18090.8 18161.8 18258.8 19270.4 19291.7 491716.0 493865.0 494972.0 495202.0 502274.0 63581.7 64038.0 64119.4 64120.4 64256.0 1401.5 1410.8 1524.9 1539.5 1556.9 30226.7 30284.8 33010.5 33178.3 33322.8 51652.0 51884.7 52308.2 52433.7 52456.7 408420.0 409933.0 410382.0 411083.0 411143.0 26703.2 29618.0 30279.8 30457.0 30609.4 43507.8 43578.0 43753.8 44513.6 44544.3 37365.4 37529.2 37858.8 39591.2 40921.8 38723.2 40171.0 40217.4 40817.8 40890.4 40756.0 40932.8 41334.2 41519.4 41669.4 35333.0 38897.8 39571.4 40023.2 40231.0 26586.6 26926.0 27155.0 28361.0 28457.3 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:31242.01 Median:2094.45 stddev:93290.70 (4454.2%) stddev-sans-first:93523.69 05:06:42 INFO - PROCESS | 1653 | Values: 416.7 426.7 427.4 437.2 438.4 17921.9 18491.0 18503.2 18749.0 19634.8 17968.5 18716.3 18786.2 20019.7 20367.5 5069.8 5198.4 5211.7 5475.1 5751.0 5547.6 5711.1 5717.9 5727.7 5737.7 5638.8 5683.0 5688.1 5689.0 5715.9 5525.4 5657.4 5678.5 5728.5 5740.3 5051.3 5162.8 5164.3 5181.1 5271.2 13384.2 14004.9 22583.8 23324.8 23398.0 2400.5 2425.9 2459.2 2764.1 2859.2 9686.8 10602.5 10749.8 10753.6 14647.7 2038.9 2077.0 2089.3 2099.5 2144.2 79130.6 79144.6 79467.2 79768.0 80482.6 11433.7 11457.5 11592.9 11684.6 11765.8 16414.3 16442.0 16666.3 16713.4 16734.0 8353.6 8469.9 8691.7 8798.7 8818.7 8498.1 8513.1 8535.1 8555.7 8630.5 4804.6 4906.1 4958.5 4980.2 5002.6 1947.8 1987.2 2008.1 2016.9 2051.5 1066.6 1125.6 1131.7 1135.2 1140.4 18795.0 18847.8 19135.0 19550.8 19552.4 1054.5 1075.8 1088.8 1108.4 1115.4 10692.4 11039.8 11067.9 11284.0 11335.3 559090.0 563069.0 565599.0 570491.0 580385.0 85783.0 95274.0 100326.5 103140.5 103298.0 1103.8 1111.1 1122.5 1128.8 1137.9 17216.2 17750.6 17812.9 17852.1 17989.6 40379.2 40467.2 40556.6 41133.0 41166.8 52658.0 53847.7 53998.5 57022.7 59569.4 8890.5 8908.5 9050.8 9203.9 9215.2 12743.4 13537.3 13687.2 13920.7 13995.9 11585.0 11590.5 11605.8 11722.2 11895.8 11317.5 11603.1 11643.6 11738.6 11783.0 11214.9 12131.5 12184.8 12388.2 12485.9 9096.2 9168.4 9266.5 9288.5 9376.7 9362.4 12128.0 12159.0 12438.1 12462.7 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5819.19 Median:4608.01 stddev:3267.26 (70.9%) stddev-sans-first:3258.66 05:06:42 INFO - PROCESS | 1653 | Values: 1285.4 1328.1 1336.1 1431.2 1495.3 8108.0 8219.7 8277.1 8312.3 8322.5 8383.0 8535.4 8545.5 8583.1 8616.1 2407.7 2419.6 2438.7 2440.0 2442.3 2412.7 2449.6 2462.3 2465.6 2472.7 2394.1 2403.0 2408.0 2428.6 2440.8 2344.1 2415.4 2426.0 2446.7 2449.3 2355.7 2430.4 2443.2 2445.3 2447.3 7555.8 8309.7 8844.9 8871.0 8891.8 5132.9 5281.7 5290.6 5293.8 5294.2 3321.8 3329.4 3377.2 3541.0 3594.5 1119.4 1120.4 1130.1 1133.4 1156.7 12399.4 12458.1 12494.7 12542.9 12561.4 4504.9 4567.7 4648.3 4652.8 4664.3 10664.5 10695.3 10699.6 10703.6 10717.2 5369.4 5378.9 5380.4 5384.4 5384.6 4932.5 4935.8 4938.9 4940.4 4941.2 3725.4 3746.4 3769.1 3825.6 3835.2 1121.5 1132.9 1136.2 1149.8 1150.7 1082.7 1098.5 1106.9 1109.3 1113.9 6021.5 6157.4 6189.7 6195.7 6201.5 1015.5 1017.5 1025.0 1052.9 1068.6 4210.0 4220.1 4223.6 4239.4 4243.8 10416.4 10802.4 10847.0 10937.5 10955.7 10724.0 10779.2 10907.6 11074.4 11080.7 8016.8 8219.1 8401.2 8507.2 8521.7 5824.8 5903.4 5921.3 5992.7 6195.6 9342.2 9771.5 9834.0 9946.6 10063.3 9885.3 9902.5 9945.5 10093.2 10122.8 7921.6 7975.6 8012.1 8042.4 8050.8 8156.5 8327.3 8443.5 8536.8 8546.4 7671.2 7761.7 7772.2 7781.7 7809.1 7636.1 7642.7 7676.9 7727.2 7789.9 7087.3 7123.1 7153.9 7160.8 7167.1 4492.8 5191.1 5311.4 5468.0 5486.3 5315.1 5322.4 5366.3 5382.1 5403.4 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:5380.84 Median:6111.39 stddev:1619.67 (26.5%) stddev-sans-first:1579.74 05:06:42 INFO - PROCESS | 1653 | Values: 358.7 358.9 361.8 366.1 366.9 6075.0 6083.8 6083.9 6110.0 6110.5 6064.1 6065.8 6066.5 6098.2 6101.9 4484.7 4590.4 4656.6 4665.8 4669.2 4653.1 4672.8 4675.3 4691.4 4714.0 4483.0 4647.7 4673.4 4677.9 4681.4 4574.3 4632.0 4687.0 4695.4 4697.3 4139.2 4152.3 4153.2 4161.3 4161.9 5837.3 5856.5 5858.9 5862.6 5867.4 5423.8 5433.8 5434.7 5436.2 5437.2 6351.5 6354.1 6354.4 6364.2 6364.2 4340.7 4446.2 4469.8 4481.6 4485.7 6547.3 6649.5 6652.1 6656.4 6667.4 4551.9 4563.4 4563.9 4567.3 4567.5 4616.7 4623.7 4625.7 4626.7 4634.4 5306.2 5306.3 5324.7 5325.9 5330.7 6233.9 6396.9 6410.3 6428.3 6430.8 1601.7 1618.4 1623.5 1629.5 1629.6 1012.6 1068.5 1071.3 1077.1 1083.5 6112.3 6123.5 6130.0 6142.2 6172.1 6481.1 6483.9 6493.5 6504.9 6510.3 6160.5 6164.8 6172.9 6177.5 6194.2 3476.1 3484.7 3503.2 3512.1 3514.8 6827.6 6871.7 7019.9 7020.1 7033.5 6726.8 6745.0 6796.5 6837.1 6878.3 6987.7 6989.2 6997.3 6999.1 7004.8 6591.8 6602.9 6604.4 6610.9 6635.3 6424.2 6534.5 6557.1 6569.4 6577.8 6918.4 6927.4 6954.6 6962.2 6972.0 4560.4 4583.9 4589.9 4600.3 4602.0 6601.4 6606.3 6608.7 6617.6 6625.4 6250.5 6426.5 6432.2 6435.8 6437.7 6388.9 6421.9 6422.8 6426.0 6435.5 6303.9 6305.0 6311.9 6317.7 6326.6 6441.8 6449.0 6453.4 6465.6 6519.6 6024.2 6158.5 6197.8 6327.3 6336.5 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:15211.49 Median:4676.96 stddev:16976.55 (363.0%) stddev-sans-first:16989.87 05:06:42 INFO - PROCESS | 1653 | Values: 840.8 857.8 901.1 917.4 924.4 14823.3 14981.8 15028.5 15049.2 15067.2 12809.1 12839.6 12929.4 12942.2 12956.8 750.8 882.0 897.1 904.6 914.4 907.3 910.7 911.4 912.6 913.0 956.4 962.1 962.9 963.4 963.4 791.6 941.7 951.9 953.5 960.5 690.9 698.8 700.0 700.3 700.8 14568.9 14592.3 14616.0 14653.8 14658.9 14304.5 14318.9 14450.9 14572.1 14677.7 11954.1 11960.4 12084.3 12237.3 12327.6 4056.0 4071.3 4078.7 4118.4 4225.0 53246.5 53292.9 53560.7 53640.7 53671.0 10595.0 10940.7 10963.2 11150.3 11233.6 19910.5 19949.0 20113.2 20141.2 20213.9 8820.0 9018.4 9153.5 9158.9 9199.3 5136.6 5143.9 5178.5 5213.5 5238.9 3475.0 3531.1 3535.5 3537.7 3538.4 593.9 657.4 666.0 667.6 677.7 696.7 709.4 724.7 814.2 832.4 9914.0 10175.9 10197.0 10226.8 10230.7 741.5 767.7 807.1 845.9 847.2 4666.3 4687.6 4785.5 4799.7 4817.8 60769.0 60902.7 61559.0 62255.6 62297.7 52530.5 53480.0 53868.7 54413.0 54646.5 48047.5 48140.5 48242.0 48580.8 48634.3 9176.0 9363.5 9404.0 9426.2 9441.8 35592.6 37750.6 38912.2 39108.4 39129.8 46145.8 47491.8 47838.5 48551.5 48983.8 12730.9 12906.9 13093.0 13106.9 13337.8 13975.4 14201.5 14254.7 14323.4 14496.0 13263.5 13412.3 13514.4 13571.0 13732.5 13766.2 13796.2 13850.0 13863.4 13939.3 13203.1 13443.3 13454.7 13490.9 13965.7 11259.6 11389.3 11468.4 11511.7 11721.6 11027.3 11053.4 11287.4 11340.5 11381.4 05:06:42 INFO - PROCESS | 1653 | -------- Summary: end -------- 05:06:42 INFO - PROCESS | 1653 | 05:06:42 INFO - TEST-INFO | 1653: exit 0 05:06:42 INFO - TEST-OK | dromaeo_css | took 1111168ms 05:06:42 INFO - TEST-START | kraken 05:06:42 INFO - operating with platform_type : linux_ 05:06:42 INFO - Initialising browser for kraken test... 05:06:42 INFO - TEST-INFO | started process 1839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWJTl7B/profile http://localhost:59011/getInfo.html) 05:06:46 INFO - PROCESS | 1839 | __metrics Screen width/height:1600/1200 05:06:46 INFO - PROCESS | 1839 | colorDepth:24 05:06:46 INFO - PROCESS | 1839 | Browser inner width/height: 1024/697 05:06:46 INFO - PROCESS | 1839 | __metrics 05:06:47 INFO - PROCESS | 1839 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:06:47 ERROR - PROCESS | 1839 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:06:48 INFO - TEST-INFO | 1839: exit 0 05:06:48 INFO - Browser initialized. 05:06:48 INFO - Running cycle 1/1 for kraken test... 05:06:48 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWJTl7B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:00 INFO - PROCESS | 1934 | RSS: Main: 139182080 05:07:00 INFO - PROCESS | 1934 | 05:07:02 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59011/tests/kraken/driver.html?testName=audio-beat-detection) 05:07:03 INFO - PROCESS | 1934 | RSS: Main: 197697536 05:07:03 INFO - PROCESS | 1934 | 05:07:06 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59011/tests/kraken/driver.html?testName=audio-dft) 05:07:06 INFO - PROCESS | 1934 | RSS: Main: 184086528 05:07:06 INFO - PROCESS | 1934 | 05:07:09 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59011/tests/kraken/driver.html?testName=audio-fft) 05:07:10 INFO - PROCESS | 1934 | RSS: Main: 273100800 05:07:10 INFO - PROCESS | 1934 | 05:07:12 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59011/tests/kraken/driver.html?testName=audio-oscillator) 05:07:12 INFO - PROCESS | 1934 | RSS: Main: 179691520 05:07:12 INFO - PROCESS | 1934 | 05:07:15 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59011/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:07:15 INFO - PROCESS | 1934 | RSS: Main: 178069504 05:07:15 INFO - PROCESS | 1934 | 05:07:18 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59011/tests/kraken/driver.html?testName=imaging-darkroom) 05:07:19 INFO - PROCESS | 1934 | RSS: Main: 212955136 05:07:19 INFO - PROCESS | 1934 | 05:07:22 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59011/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:23 INFO - PROCESS | 1934 | RSS: Main: 212152320 05:07:23 INFO - PROCESS | 1934 | 05:07:25 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59011/tests/kraken/driver.html?testName=json-parse-financial) 05:07:26 INFO - PROCESS | 1934 | RSS: Main: 212905984 05:07:26 INFO - PROCESS | 1934 | 05:07:28 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59011/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:28 INFO - PROCESS | 1934 | RSS: Main: 196202496 05:07:28 INFO - PROCESS | 1934 | 05:07:30 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:30 INFO - PROCESS | 1934 | RSS: Main: 199151616 05:07:30 INFO - PROCESS | 1934 | 05:07:32 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:33 INFO - PROCESS | 1934 | RSS: Main: 210669568 05:07:33 INFO - PROCESS | 1934 | 05:07:35 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:36 INFO - PROCESS | 1934 | RSS: Main: 218243072 05:07:36 INFO - PROCESS | 1934 | 05:07:39 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:39 INFO - PROCESS | 1934 | RSS: Main: 214093824 05:07:39 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:59011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59011/tests/kraken/driver.html?testName=ai-astar) 05:07:41 INFO - PROCESS | 1934 | RSS: Main: 274223104 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | __start_tp_report 05:07:41 INFO - PROCESS | 1934 | _x_x_mozilla_page_load 05:07:41 INFO - PROCESS | 1934 | _x_x_mozilla_page_load_details 05:07:41 INFO - PROCESS | 1934 | |i|pagename|runs| 05:07:41 INFO - PROCESS | 1934 | |0;ai-astar;110;110;109;109;109;110;104;109;112;108 05:07:41 INFO - PROCESS | 1934 | |1;audio-beat-detection;163;125;157;190;129;154;152;127;193;127 05:07:41 INFO - PROCESS | 1934 | |2;audio-dft;162;161;160;160;159;159;160;161;160;159 05:07:41 INFO - PROCESS | 1934 | |3;audio-fft;73;74;72;176;77;77;76;75;162;78 05:07:41 INFO - PROCESS | 1934 | |4;audio-oscillator;93;93;157;92;92;92;158;91;93;151 05:07:41 INFO - PROCESS | 1934 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;116;116 05:07:41 INFO - PROCESS | 1934 | |6;imaging-darkroom;145;146;146;145;145;145;145;146;145;146 05:07:41 INFO - PROCESS | 1934 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;95;94 05:07:41 INFO - PROCESS | 1934 | |8;json-parse-financial;55;56;53;57;54;55;58;79;54;52 05:07:41 INFO - PROCESS | 1934 | |9;json-stringify-tinderbox;59;67;57;67;58;59;58;59;58;59 05:07:41 INFO - PROCESS | 1934 | |10;stanford-crypto-aes;73;73;72;73;73;74;73;81;73;74 05:07:41 INFO - PROCESS | 1934 | |11;stanford-crypto-ccm;122;118;116;116;114;112;114;119;131;117 05:07:41 INFO - PROCESS | 1934 | |12;stanford-crypto-pbkdf2;168;164;168;164;163;167;165;163;160;161 05:07:41 INFO - PROCESS | 1934 | |13;stanford-crypto-sha256-iterative;67;69;69;68;68;69;67;67;67;67 05:07:41 INFO - PROCESS | 1934 | __end_tp_report 05:07:41 INFO - PROCESS | 1934 | __start_cc_report 05:07:41 INFO - PROCESS | 1934 | _x_x_mozilla_cycle_collect,1592 05:07:41 INFO - PROCESS | 1934 | __end_cc_report 05:07:41 INFO - PROCESS | 1934 | __startTimestamp1469448461843__endTimestamp 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | ------- Summary: start ------- 05:07:41 INFO - PROCESS | 1934 | Number of tests: 14 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:2.05 (1.9%) stddev-sans-first:2.15 05:07:41 INFO - PROCESS | 1934 | Values: 110.0 110.0 109.0 109.0 109.0 110.0 104.0 109.0 112.0 108.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.50 stddev:25.35 (16.3%) stddev-sans-first:26.55 05:07:41 INFO - PROCESS | 1934 | Values: 163.0 125.0 157.0 190.0 129.0 154.0 152.0 127.0 193.0 127.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:0.78 05:07:41 INFO - PROCESS | 1934 | Values: 162.0 161.0 160.0 160.0 159.0 159.0 160.0 161.0 160.0 159.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.71 (52.6%) stddev-sans-first:41.39 05:07:41 INFO - PROCESS | 1934 | Values: 73.0 74.0 72.0 176.0 77.0 77.0 76.0 75.0 162.0 78.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:92.00 stddev:30.51 (33.2%) stddev-sans-first:31.65 05:07:41 INFO - PROCESS | 1934 | Values: 93.0 93.0 157.0 92.0 92.0 92.0 158.0 91.0 93.0 151.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:07:41 INFO - PROCESS | 1934 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:07:41 INFO - PROCESS | 1934 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 05:07:41 INFO - PROCESS | 1934 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:55.50 stddev:7.83 (14.1%) stddev-sans-first:8.26 05:07:41 INFO - PROCESS | 1934 | Values: 55.0 56.0 53.0 57.0 54.0 55.0 58.0 79.0 54.0 52.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:59.00 stddev:3.70 (6.3%) stddev-sans-first:3.90 05:07:41 INFO - PROCESS | 1934 | Values: 59.0 67.0 57.0 67.0 58.0 59.0 58.0 59.0 58.0 59.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.00 stddev:2.56 (3.5%) stddev-sans-first:2.69 05:07:41 INFO - PROCESS | 1934 | Values: 73.0 73.0 72.0 73.0 73.0 74.0 73.0 81.0 73.0 74.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:117.50 stddev:5.40 (4.6%) stddev-sans-first:5.53 05:07:41 INFO - PROCESS | 1934 | Values: 122.0 118.0 116.0 116.0 114.0 112.0 114.0 119.0 131.0 117.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.50 stddev:2.75 (1.7%) stddev-sans-first:2.57 05:07:41 INFO - PROCESS | 1934 | Values: 168.0 164.0 168.0 164.0 163.0 167.0 165.0 163.0 160.0 161.0 05:07:41 INFO - PROCESS | 1934 | 05:07:41 INFO - PROCESS | 1934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 05:07:41 INFO - PROCESS | 1934 | Values: 67.0 69.0 69.0 68.0 68.0 69.0 67.0 67.0 67.0 67.0 05:07:41 INFO - PROCESS | 1934 | -------- Summary: end -------- 05:07:41 INFO - PROCESS | 1934 | 05:07:42 INFO - TEST-INFO | 1934: exit 0 05:07:42 INFO - TEST-OK | kraken | took 60058ms 05:07:42 INFO - SUITE-END | took 1171s 05:07:42 INFO - Completed test suite (00:19:31) 05:07:42 INFO - javascript benchmark 05:07:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.801711897286, 3364.276680513689, 3370.140614143393, 3393.406153923063, 3407.4548072308435, 5460.945390546093, 5466.125419932801, 5479.342478902532, 5483.780648774049, 5493.725313734317, 5401.0, 5488.4237155098635, 5505.229267902497, 5516.117421212607, 5531.308586426697, 4849.660523763338, 4959.03298856724, 5067.214581739836, 5113.923291150636, 5147.639665223436, 4914.926276105862, 4988.725620090893, 5023.974880125595, 5024.120778863702, 5032.295478632995, 4951.0592987332475, 5023.673461225027, 5086.237064440345, 5112.41207261166, 5116.258142569325, 5070.61970352225, 5081.161608334621, 5094.439611642716, 5097.158968770148, 5116.1814109742445, 4903.4606193318705, 4906.190478571068, 4987.501249875019, 4998.650094493387, 5006.249062640597, 5382.91925621116, 5400.135978243462, 5431.83704488866, 5432.049391356536, 5444.0, 5836.474717275423, 5877.353491115974, 5879.088741245114, 5880.353161152269, 5880.9411905880825, 5791.044477661181, 5835.737391817378, 5890.528757699374, 5893.764249430018, 5944.940550594482, 5501.944980550184, 5514.944850551483, 5548.4174161713245, 5553.861153471155, 5557.305336832896, 5810.767569297265, 6011.939880601138, 6029.0, 6038.698065096728, 6047.365026672224, 5718.7426565804635, 5824.796132135355, 5826.970865145732, 5836.037053886062, 5838.766449341979, 5868.2077919480325, 5872.941270587325, 5881.529477641779, 5882.205902203234, 5887.175795388649, 5691.060974939089, 5695.40198279183, 5828.417158284223, 5834.708264586754, 5841.766329346863, 5823.505002074787, 5855.677937713466, 5861.531077513789, 5864.70676466175, 5896.204012458349, 4515.412996310459, 4540.909181816345, 4542.545745425497, 4545.3863728396245, 4571.337156112345, 4023.5775243599587, 4028.295048366524, 4068.1253530490494, 4098.672106231495, 4111.301078816608, 5529.142982837667, 5544.944550554524, 5558.583106266965, 5581.860453488695, 5588.0, 5831.795887144014, 5833.620814647034, 5834.3290521589715, 5835.299764028344, 5839.445252700986, 5506.449355064542, 5553.444655534414, 5571.192177134293, 5628.493435590816, 5635.859103522363, 5062.088824011713, 5104.668196567285, 5119.744012799345, 5127.359080114986, 5133.25567792668, 6174.629522228591, 6193.969030154821, 6195.96902015487, 6198.2252218472695, 6204.627722336674, 5774.989376859033, 5816.76732930678, 5889.087191485327, 5910.52715782745, 5911.497522710618, 6170.845728856814, 6202.317745048132, 6202.937970620416, 6212.751489940532, 6219.813405597839, 5642.266505354278, 5826.417358264309, 5836.678982655994, 5836.824895253149, 5859.296884373903, 5831.7375718091935, 5863.941360586339, 5888.087346461305, 5892.646441213541, 5924.8815023700145, 5713.542916566747, 5728.971355143198, 5753.654780713171, 5757.4242575743765, 5757.65454072757, 5601.0, 5689.118186681071, 5732.742026608729, 5747.856303592276, 5754.079347304411, 5605.5515558756015, 5610.270664813711, 5610.635308704921, 5614.6631202128, 5662.122371032497, 5706.572007099401, 5710.0, 5710.400407957105, 5718.942810572007, 5721.399253078534, 5567.220589117445, 5609.21470994053, 5623.971880140573, 5645.040343141593, 5728.283964504437], "value": 5433.365517415284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3198705333508, 670.3932940688677, 673.5924765516862, 739.956661107838, 744.4007573903012, 33045.83477082614, 33765.83117084414, 41128.0, 41819.372709409385, 41860.0, 43210.78394608023, 43569.7821510892, 43728.781356093175, 43771.3434298485, 43860.78069609655, 8581.957090214555, 8858.955705221464, 8860.689875854347, 8871.201591856732, 8871.95564022179, 8765.342599305046, 8925.553722313858, 8935.910640893606, 8943.95528022359, 8947.373683842134, 9133.95433022834, 9178.54107294636, 9186.908130918671, 9208.953955230214, 9215.078492150798, 9087.182153606174, 9128.863067053999, 9164.266858651292, 9169.95415022924, 9172.266218702554, 9010.324225683034, 9103.908960910372, 9116.498592577405, 9119.179273865384, 9119.316051296179, 43797.12405751867, 44287.11425771499, 44343.0, 44364.0, 44407.11185776299, 3800.182960663443, 3988.4615576897036, 4157.08544120293, 4247.426597409341, 4487.955120448786, 33770.0, 33917.49123763145, 34136.82931585326, 34333.484997725056, 35235.647643523494, 4459.353393757887, 4555.385023021883, 4575.428071491064, 4580.358749775034, 4591.058832939239, 219339.0, 219901.0, 222804.0, 298324.0, 298347.0, 39493.40759888604, 60577.0, 60928.0, 61004.38995610076, 61005.694971524856, 38059.61940380616, 38146.618533814304, 38270.80864595659, 38280.80859595684, 38293.617063829006, 16986.660266794843, 17261.223244954006, 17262.309507619553, 17269.050202238745, 17273.309067637154, 14480.203588802717, 14529.491467798576, 14532.346044428026, 14573.344199510835, 14573.635659108608, 9106.453612783254, 9199.356045076915, 9244.306676999118, 9278.118578735144, 9342.766430839147, 3508.122969257686, 3525.1539630488496, 3545.7695249809194, 3571.589267234301, 3640.3265395901844, 1049.611643691839, 1096.7641956979287, 1195.1574140231116, 1236.0605939485877, 1267.9683007924875, 33482.3303533928, 33529.66470335314, 34150.14624634404, 34323.31353372918, 34868.65131348705, 1219.2379762648345, 1222.908281878845, 1238.5726924211133, 1246.2771592476342, 1254.1534464236604, 18090.819091809175, 18161.818381816014, 18258.807080618233, 19270.421887343404, 19291.710624340645, 491716.0, 493865.0, 494972.0, 495202.0, 502274.0, 63581.682091589246, 64038.0, 64119.358806411336, 64120.35879641144, 64256.0, 1401.509471684902, 1410.7742761158165, 1524.8780097592166, 1539.4688832352597, 1556.8754499640002, 30226.670181704616, 30284.84857575698, 33010.504842426904, 33178.33643327168, 33322.83338583291, 51652.0, 51884.74057629688, 52308.21537677014, 52433.73783131212, 52456.737716311174, 408420.0, 409933.0, 410382.0, 411083.0, 411143.0, 26703.19890403291, 29618.0, 30279.848600756854, 30457.0, 30609.387812244076, 43507.78246108749, 43578.0, 43753.78123109364, 44513.55486445094, 44544.331835021854, 37365.4395184067, 37529.249415011, 37858.81070594629, 39591.208175835745, 40921.79539102285, 38723.22553548857, 40171.0, 40217.39673904952, 40817.77546673604, 40890.38664420095, 40756.0, 40932.795336023126, 41334.1733165341, 41519.37720934128, 41669.37495937624, 35333.0, 38897.80551097226, 39571.40642890416, 40023.1995360097, 40231.0, 26586.601200981615, 26926.0, 27155.04957326484, 28360.983270876648, 28457.28856778597], "value": 19414.02510831387, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.68956627312656, 426.66506792168144, 427.4315160836088, 437.20647025648447, 438.44755607934, 17921.910390448047, 18491.0, 18503.16735746893, 18749.0, 19634.84016758159, 17968.460946171603, 18716.25134994602, 18786.248550058015, 20019.699704504445, 20367.49081272965, 5069.797208111671, 5198.3761948566225, 5211.739413029352, 5475.06923822951, 5750.971245143789, 5547.55619550435, 5711.114777209518, 5717.885642287151, 5727.713614319288, 5737.741801618937, 5638.802641907534, 5683.0, 5688.061469857468, 5688.971555142219, 5715.942840571583, 5525.364583072937, 5657.434256574351, 5678.517326027292, 5728.455796699307, 5740.339860915986, 5051.292819005305, 5162.819301324435, 5164.2770012198325, 5181.093308670967, 5271.156614941629, 13384.19694818314, 14004.859951400458, 22583.77416225833, 23324.76675233243, 23398.0, 2400.4838959623767, 2425.8787060646896, 2459.237636332725, 2764.087851009162, 2859.1565488180827, 9686.806263874754, 10602.469876506144, 10749.83875241872, 10753.623623173151, 14647.70704585913, 2038.9286374976805, 2077.02379881457, 2089.341857314941, 2099.548597051641, 2144.2280778919576, 79130.60434697848, 79144.60427697882, 79467.20532794714, 79768.0, 80482.59758701228, 11433.742288348276, 11457.541698331974, 11592.942035289938, 11684.591039313584, 11765.823512647317, 16414.26135823891, 16442.0, 16666.250018749186, 16713.415030473876, 16734.0, 8353.582320883932, 8469.872951905727, 8691.739247822576, 8798.736037918872, 8818.691345802994, 8498.065212826585, 8513.063563008063, 8535.061143274235, 8555.743327700178, 8630.482171069756, 4804.591609713214, 4906.092372911023, 4958.479359667255, 4980.203167493184, 5002.599272203789, 1947.8149575790278, 1987.2448469581466, 2008.116428771336, 2016.939491815248, 2051.4563640634947, 1066.5787014129376, 1125.611663975927, 1131.7340425000118, 1135.1769966774023, 1140.4262118276724, 18795.0, 18847.811521884607, 19135.0, 19550.8044919549, 19552.413427597196, 1054.4569546683465, 1075.8224892892586, 1088.820344643125, 1108.4457771114444, 1115.4422788605698, 10692.411917344622, 11039.779204415867, 11067.944660276808, 11284.0, 11335.263207891461, 559090.0, 563069.0, 565599.0, 570491.0, 580385.0, 85783.0, 95274.0, 100326.49836750915, 103140.48429757803, 103298.0, 1103.8178700514486, 1111.1333160135107, 1122.5004872831512, 1128.841962125303, 1137.9487923043482, 17216.22526986314, 17750.644987100444, 17812.91093544524, 17852.10739462996, 17989.64020719552, 40379.19241615092, 40467.190656186125, 40556.59443405528, 41133.0, 41166.79416602898, 52658.0, 53847.73076134594, 53998.460015399345, 57022.7148864253, 59569.404305958116, 8890.511021893857, 8908.465492070496, 9050.773730656787, 9203.86194207074, 9215.216706580015, 12743.426545805276, 13537.255450950292, 13687.247201404018, 13920.721585568435, 13995.930020349833, 11585.0, 11590.478428470908, 11605.767884642091, 11722.238054526428, 11895.76208475843, 11317.547298107984, 11603.12976526747, 11643.59247426336, 11738.647840564796, 11783.0, 11214.943925280322, 12131.514739410324, 12184.75630487403, 12388.194767340094, 12485.87514124847, 9096.226820720312, 9168.358214925158, 9266.53667316618, 9288.489133097744, 9376.67181648639, 9362.391444556082, 12128.0, 12159.0, 12438.129330946747, 12462.688432789253], "value": 9475.324415673573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.395863943946, 1328.136711137761, 1336.131514515565, 1431.2056808471293, 1495.3420494982213, 8108.0, 8219.71231006915, 8277.130901255372, 8312.335013198937, 8322.542260175687, 8383.0, 8535.445196062252, 8545.487270763759, 8583.098774628668, 8616.138386161381, 2407.7471865454136, 2419.6491508731224, 2438.6951631046118, 2440.036185706645, 2442.255112190781, 2412.6984126984125, 2449.5590793657134, 2462.261321603512, 2465.642481840132, 2472.7279999200073, 2394.0902457066377, 2402.9639555406684, 2407.9518409631796, 2428.611422172453, 2440.8413453125577, 2344.120954642009, 2415.3961509622595, 2425.9514809703796, 2446.681931348931, 2449.2652204338715, 2355.6819829323163, 2430.4409985703387, 2443.218170185541, 2445.2664200739705, 2447.2535876557645, 7555.848883022309, 8309.709160179365, 8844.911550884473, 8870.955645221797, 8891.777705557413, 5132.897342053138, 5281.683099014072, 5290.60320475962, 5293.7617807198385, 5294.232336311214, 3321.7840840345543, 3329.350776598564, 3377.206356506219, 3540.964590354115, 3594.514740510024, 1119.4067144413473, 1120.3781901044918, 1130.0789856267115, 1133.3766428464312, 1156.6587856582328, 12399.442025108892, 12458.12793104483, 12494.687632809162, 12542.874571254262, 12561.371931403484, 4504.864854054384, 4567.703099298601, 4648.3259927310355, 4652.813887444532, 4664.300354946718, 10664.520096595672, 10695.251332406813, 10699.572017119384, 10703.571857125784, 10717.196210284104, 5369.355677318668, 5378.91931621026, 5380.381256155514, 5384.40771515133, 5384.596155288369, 4932.53140951609, 4935.802567897315, 4938.851834444972, 4940.407151141886, 4941.160002799533, 3725.3666876631037, 3746.3631182699005, 3769.095417099876, 3825.617438256152, 3835.1562656215588, 1121.5457739615306, 1132.898039176478, 1136.181948996721, 1149.816029435303, 1150.6893138852463, 1082.7455547946226, 1098.5001824170142, 1106.8948449897248, 1109.2623405435456, 1113.9275947063416, 6021.458068773832, 6157.384261573897, 6189.659568723763, 6195.690215489208, 6201.503879689614, 1015.5125539740818, 1017.5217647705566, 1025.031345378625, 1052.9105026072716, 1068.5992752717732, 4209.97895010523, 4220.092680073799, 4223.577642235752, 4239.364095385655, 4243.766592837362, 10416.427096509764, 10802.405867677353, 10847.0, 10937.507812148473, 10955.671329860117, 10724.03483686472, 10779.245452818228, 10907.618233361794, 11074.390908499949, 11080.722981925355, 8016.759497215093, 8219.054808696957, 8401.243888049983, 8507.191816777397, 8521.701740439055, 5824.807483487924, 5903.409659034062, 5921.289445266596, 5992.700364981821, 6195.597286176384, 9342.159205671522, 9771.462569558742, 9834.0, 9946.602135914482, 10063.345882517613, 9885.258605604464, 9902.504874756378, 9945.502724863873, 10093.19254459656, 10122.848157277795, 7921.603919803872, 7975.601219939096, 8012.078610959814, 8042.437029407885, 8050.838983220186, 8156.510609363457, 8327.250547450758, 8443.493390396596, 8536.786580335542, 8546.401751877309, 7671.194524574839, 7761.72833950809, 7772.222777722182, 7781.688732450639, 7809.140994490488, 7636.08366995964, 7642.7325043623205, 7676.884846727416, 7727.227277272453, 7789.922100779147, 7087.291270872872, 7123.074000379917, 7153.928460715326, 7160.785176444715, 7167.104111986002, 4492.842750503717, 5191.091558977239, 5311.415744268204, 5468.0, 5486.31421072366, 5315.123004704181, 5322.441143680013, 5366.302380690485, 5382.085045542189, 5403.351597808288], "value": 4680.864221312737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.74887578694904, 358.92821435712864, 361.8389816531643, 366.12861389892055, 366.8862652577701, 6075.0, 6083.817485475432, 6083.939160608393, 6109.9999999999945, 6110.480609148228, 6064.06007068905, 6065.787697430591, 6066.484348830344, 6098.237720284965, 6101.87796244076, 4484.686071974963, 4590.40324757781, 4656.6274698024245, 4665.790039448216, 4669.159551280768, 4653.092646933849, 4672.836450724225, 4675.298705194231, 4691.366665500165, 4714.033623107255, 4482.97758511207, 4647.674662773607, 4673.369095172142, 4677.9064418711605, 4681.368015317923, 4574.2909848973295, 4632.0, 4687.039156972846, 4695.389599352063, 4697.271922851946, 4139.19285739281, 4152.335626299778, 4153.231652144333, 4161.313383291784, 4161.854335098287, 5837.299524057098, 5856.5314774818335, 5858.853528661775, 5862.589618726691, 5867.354590994987, 5423.810166644149, 5433.755481003364, 5434.673919564799, 5436.21174929633, 5437.211604317391, 6351.523635727339, 6354.078658594524, 6354.4281014708895, 6364.172657554488, 6364.204474440695, 4340.696151269412, 4446.244138496463, 4469.7988590513505, 4481.551844815525, 4485.663575231838, 6547.3125321841, 6649.5012874034155, 6652.068710380599, 6656.434203092743, 6667.399934005963, 4551.931721024187, 4563.406757121553, 4563.9087218255445, 4567.269236922143, 4567.497575266718, 4616.699914505546, 4623.676342656049, 4625.722456652612, 4626.699264547794, 4634.397528321297, 5306.177542480922, 5306.28365170697, 5324.653897496651, 5325.946740532545, 5330.653507521999, 6233.906491402633, 6396.936030639634, 6410.262819775786, 6428.260750013715, 6430.77492287777, 1601.719699052661, 1618.360747504729, 1623.4967160180381, 1629.5030015845043, 1629.576310159367, 1012.6152062216458, 1068.5031460370965, 1071.346478648024, 1077.0844781935448, 1083.534080345459, 6112.297085835097, 6123.510119190454, 6130.049842274366, 6142.170806941006, 6172.135900973867, 6481.125048118443, 6483.870322593616, 6493.545451818327, 6504.869902601921, 6510.283868774431, 6160.537959653044, 6164.815055548341, 6172.9074063889075, 6177.505799536116, 6194.163787888578, 3476.1483436558206, 3484.7386446016144, 3503.211777350076, 3512.069301635018, 3514.789112653249, 6827.556208846409, 6871.725130994704, 7019.89470157948, 7020.087388639547, 7033.4724895633035, 6726.7981960541265, 6745.0, 6796.490263230277, 6837.076994605664, 6878.312168783182, 6987.6855541499735, 6989.231184569693, 6997.300269973064, 6999.055127557816, 7004.824879378057, 6591.769288074895, 6602.9009564855605, 6604.438622716931, 6610.933890661032, 6635.303293154149, 6424.196975378078, 6534.542582019213, 6557.147570815763, 6569.441597464269, 6577.835554111186, 6918.411934985583, 6927.44580433554, 6954.582725036514, 6962.23415424313, 6971.965140174267, 4560.4071470708595, 4583.854036490878, 4589.862304130881, 4600.332951722048, 4602.0, 6601.405873471411, 6606.306337834458, 6608.70260838273, 6617.602943823386, 6625.370589793962, 6250.49996000328, 6426.485881129592, 6432.195975503062, 6435.839104022437, 6437.742490300336, 6388.9041664374145, 6421.903671444838, 6422.807315780347, 6425.967870160619, 6435.549511534147, 6303.936960630518, 6304.968475157595, 6311.90532142009, 6317.684115794284, 6326.620402775849, 6441.774537891151, 6448.967755161194, 6453.386928241809, 6465.579737317059, 6519.576227545194, 6024.186734790923, 6158.507319414346, 6197.783077592263, 6327.303996560283, 6336.493080553637], "value": 4858.19626167751, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [840.848647243496, 857.8198578298557, 901.1439132823818, 917.4266083697689, 924.4083786376721, 14823.332950017248, 14981.775273370908, 15028.549143525697, 15049.172295523742, 15067.17130557819, 12809.10336276461, 12839.614811555668, 12929.418176182071, 12942.158759680615, 12956.80564791529, 750.7635094945075, 881.964721411146, 897.0984160918268, 904.6200595749801, 914.3919293669702, 907.2741806554762, 910.7040211931115, 911.4166933162782, 912.6030176873048, 913.0458670689146, 956.3783540698532, 962.1484985787558, 962.9277804164681, 963.388248462228, 963.3930623707055, 791.6239786101585, 941.6515889121035, 951.8952915179325, 953.4755884263627, 960.5149399553251, 690.8894576867727, 698.8322802527408, 699.9685014174374, 700.2927043685863, 700.7967689370076, 14568.927155364261, 14592.270386480739, 14616.0, 14653.780193297109, 14658.926705366512, 14304.499342523066, 14318.92840535801, 14450.927745361207, 14572.05281656689, 14677.706445871023, 11954.10344224178, 11960.40197990097, 12084.335361555111, 12237.265764054186, 12327.630171094881, 4055.959440405588, 4071.348584226539, 4078.7144899856726, 4118.4440100586335, 4225.0, 53246.467535324926, 53292.93414131695, 53560.73219633916, 53640.73179634116, 53671.0, 10595.0, 10940.671779846618, 10963.232573719763, 11150.275232109887, 11233.550657973752, 19910.50223744389, 19949.0, 20113.19547218095, 20141.194352225746, 20213.898930505253, 8820.0, 9018.413803102778, 9153.450792952444, 9158.908410915805, 9199.264058875275, 5136.640435169502, 5143.871403214949, 5178.533931946067, 5213.530782229617, 5238.869028274324, 3474.965250347515, 3531.099569609733, 3535.487354333607, 3537.6816086552335, 3538.433850583894, 593.8871614393252, 657.4444594317794, 665.9567128136656, 667.5927684112687, 677.7289084366195, 696.6899729620371, 709.4359983812881, 724.6811402982671, 814.2061490047275, 832.3798769916451, 9913.959544153851, 10175.907480911526, 10197.011478233075, 10226.767896095103, 10230.700089883123, 741.5365396627108, 767.7082708570707, 807.0678366486717, 845.8731190321502, 847.1909326593088, 4666.300054991711, 4687.6249900007915, 4785.473597904228, 4799.712017278975, 4817.759112044454, 60769.0, 60902.69548652317, 61559.0, 62255.64210505221, 62297.68851155806, 52530.47469525256, 53480.0, 53868.73065634725, 54413.0, 54646.453535464934, 48047.5195248043, 48140.518594813606, 48242.03515929732, 48580.75709621429, 48634.27048594274, 9176.001991535972, 9363.531823408666, 9403.952980235055, 9426.151646351587, 9441.811163776823, 35592.644073558935, 37750.62249377471, 38912.2217555653, 39108.41337379999, 39129.804350979204, 46145.76927115343, 47491.762541187076, 47838.5216147848, 48551.51448485611, 48983.755081224364, 12730.936345318214, 12906.870931290567, 13093.0, 13106.868931310564, 13337.799933000819, 13975.440982360999, 14201.502947396792, 14254.714905702036, 14323.355449005028, 14496.0, 13263.469461221443, 13412.32938353098, 13514.39185236647, 13571.0, 13732.519361822688, 13766.174029558259, 13796.17222966585, 13850.0, 13863.4454621814, 13939.303034848013, 13203.141795783244, 13443.260620665957, 13454.730905382034, 13490.865091349353, 13965.720685586028, 11259.605913792979, 11389.316641001566, 11468.369239691563, 11511.654650360502, 11721.589744358907, 11027.283226590567, 11053.447327633747, 11287.43562821872, 11340.489677964346, 11381.43092845338], "value": 7141.897721957483, "unit": "score"}], "name": "dromaeo_css", "value": 7385.931438997651, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 104.0, 109.0, 112.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 125.0, 157.0, 190.0, 129.0, 154.0, 152.0, 127.0, 193.0, 127.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 159.0, 159.0, 160.0, 161.0, 160.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 176.0, 77.0, 77.0, 76.0, 75.0, 162.0, 78.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 157.0, 92.0, 92.0, 92.0, 158.0, 91.0, 93.0, 151.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 53.0, 57.0, 54.0, 55.0, 58.0, 79.0, 54.0, 52.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 57.0, 67.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 73.0, 73.0, 74.0, 73.0, 81.0, 73.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 116.0, 116.0, 114.0, 112.0, 114.0, 119.0, 131.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 168.0, 164.0, 163.0, 167.0, 165.0, 163.0, 160.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 68.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1524.0, "alertThreshold": 2.0}]} 05:07:43 INFO - Return code: 0 05:07:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:07:43 ERROR - # TBPL SUCCESS # 05:07:43 INFO - Running post-action listener: _resource_record_post_action 05:07:43 INFO - Running post-run listener: _resource_record_post_run 05:07:44 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 24576; Write bytes: 463171584; Read time: 16; Write time: 450900 05:07:44 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 217952256; Read time: 0; Write time: 324180 05:07:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 220430336; Read time: 0; Write time: 122176 05:07:44 INFO - Running post-run listener: _upload_blobber_files 05:07:44 INFO - Blob upload gear active. 05:07:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:45 INFO - (blobuploader) - INFO - Done attempting. 05:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:46 INFO - (blobuploader) - INFO - Done attempting. 05:07:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:46 INFO - Return code: 0 05:07:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc30569836a49352c2c9de7d593e7ae39ec0e7213449f22d00ff6b363ef3d0083b3da190ca26f6b7c1bf80a68e4922d590926b20e3c85ccba2c0411ddeb3fd0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74a52a5a7d7c0f2550387719c7326d9e90d9559dbfdd6626739bfe43b62a6c266d6619f5ac016229fbb747e79bc59080f87b33ed8f8bfd1ec337186fc8f0d7b"} 05:07:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:46 INFO - Contents: 05:07:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc30569836a49352c2c9de7d593e7ae39ec0e7213449f22d00ff6b363ef3d0083b3da190ca26f6b7c1bf80a68e4922d590926b20e3c85ccba2c0411ddeb3fd0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74a52a5a7d7c0f2550387719c7326d9e90d9559dbfdd6626739bfe43b62a6c266d6619f5ac016229fbb747e79bc59080f87b33ed8f8bfd1ec337186fc8f0d7b"} 05:07:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:46 INFO - Copying logs to upload dir... 05:07:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.964284 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-25 05:07:44.989244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:07:44.992663) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617 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-Beta/sha512/bc30569836a49352c2c9de7d593e7ae39ec0e7213449f22d00ff6b363ef3d0083b3da190ca26f6b7c1bf80a68e4922d590926b20e3c85ccba2c0411ddeb3fd0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74a52a5a7d7c0f2550387719c7326d9e90d9559dbfdd6626739bfe43b62a6c266d6619f5ac016229fbb747e79bc59080f87b33ed8f8bfd1ec337186fc8f0d7b"} build_url:https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/FkBW4SKSTcqk7L0b4YT3Vg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc30569836a49352c2c9de7d593e7ae39ec0e7213449f22d00ff6b363ef3d0083b3da190ca26f6b7c1bf80a68e4922d590926b20e3c85ccba2c0411ddeb3fd0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d74a52a5a7d7c0f2550387719c7326d9e90d9559dbfdd6626739bfe43b62a6c266d6619f5ac016229fbb747e79bc59080f87b33ed8f8bfd1ec337186fc8f0d7b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 05:07:45.018081) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:07:45.018491) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469446170.900029-385448617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 05:07:45.101418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:07:45.101780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 05:07:45.102077) ========= ========= Total master_lag: 0.15 =========