builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1461558567.98 results: success (0) buildid: 20160424182636 builduid: b1a84459b7194c67b2cbcefbec04f387 revision: a07ea7fb572f503761e11fdae02f6d0340f157ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:27.984492) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:27.985539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:27.985804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:27.999491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:27.999746) ========= 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=00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 21:29:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.2M=0s 2016-04-24 21:29:28 (50.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.193287) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.193555) ========= 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=00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016880 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.243288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.243623) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a07ea7fb572f503761e11fdae02f6d0340f157ec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a07ea7fb572f503761e11fdae02f6d0340f157ec --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=00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 21:29:28,822 truncating revision to first 12 chars 2016-04-24 21:29:28,822 Setting DEBUG logging. 2016-04-24 21:29:28,822 attempt 1/10 2016-04-24 21:29:28,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a07ea7fb572f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 21:29:29,097 unpacking tar archive at: fx-team-a07ea7fb572f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.815995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.816258) ========= script_repo_revision: a07ea7fb572f503761e11fdae02f6d0340f157ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.816612) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.816866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 21:29:28.825407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-24 21:29:28.825662) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:29:29 INFO - MultiFileLogger online at 20160424 21:29:29 in /builds/slave/test 21:29:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:29:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:29:29 INFO - {'append_to_log': False, 21:29:29 INFO - 'base_work_dir': '/builds/slave/test', 21:29:29 INFO - 'blob_upload_branch': 'Fx-Team', 21:29:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:29:29 INFO - 'branch': 'Fx-Team', 21:29:29 INFO - 'buildbot_json_path': 'buildprops.json', 21:29:29 INFO - 'config_files': ('talos/linux_config.py',), 21:29:29 INFO - 'default_actions': ('clobber', 21:29:29 INFO - 'read-buildbot-config', 21:29:29 INFO - 'download-and-extract', 21:29:29 INFO - 'populate-webroot', 21:29:29 INFO - 'create-virtualenv', 21:29:29 INFO - 'install', 21:29:29 INFO - 'run-tests'), 21:29:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:29:29 INFO - 'download_minidump_stackwalk': True, 21:29:29 INFO - 'download_symbols': 'ondemand', 21:29:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:29:29 INFO - 'tooltool.py': '/tools/tooltool.py', 21:29:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:29:29 INFO - '/tools/misc-python/virtualenv.py')}, 21:29:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:29:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:29:29 INFO - 'installer_path': 'installer.exe', 21:29:29 INFO - 'log_level': 'info', 21:29:29 INFO - 'log_name': 'talos', 21:29:29 INFO - 'log_to_console': True, 21:29:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:29:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:29:29 INFO - 'opt_config_files': (), 21:29:29 INFO - 'pip_index': False, 21:29:29 INFO - 'sps_profile': False, 21:29:29 INFO - 'sps_profile_interval': 0, 21:29:29 INFO - 'suite': 'dromaeojs-e10s', 21:29:29 INFO - 'system_bits': '32', 21:29:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:29:29 INFO - 'title': 'talos-linux64-ix-016', 21:29:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:29:29 INFO - 'use_talos_json': True, 21:29:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:29:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:29:29 INFO - 'work_dir': 'build'} 21:29:29 INFO - ##### 21:29:29 INFO - ##### Running clobber step. 21:29:29 INFO - ##### 21:29:29 INFO - Running pre-action listener: _resource_record_pre_action 21:29:29 INFO - Running main action method: clobber 21:29:29 INFO - rmtree: /builds/slave/test/build 21:29:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:29:29 INFO - Running post-action listener: _resource_record_post_action 21:29:29 INFO - ##### 21:29:29 INFO - ##### Running read-buildbot-config step. 21:29:29 INFO - ##### 21:29:29 INFO - Running pre-action listener: _resource_record_pre_action 21:29:29 INFO - Running main action method: read_buildbot_config 21:29:29 INFO - Using buildbot properties: 21:29:29 INFO - { 21:29:29 INFO - "project": "", 21:29:29 INFO - "product": "firefox", 21:29:29 INFO - "script_repo_revision": "production", 21:29:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:29:29 INFO - "repository": "", 21:29:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:29:29 INFO - "buildid": "20160424182636", 21:29:29 INFO - "pgo_build": "True", 21:29:29 INFO - "basedir": "/builds/slave/test", 21:29:29 INFO - "buildnumber": 411, 21:29:29 INFO - "slavename": "talos-linux64-ix-016", 21:29:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:29:29 INFO - "platform": "ubuntu64_hw", 21:29:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:29:29 INFO - "branch": "fx-team", 21:29:29 INFO - "repo_path": "integration/fx-team", 21:29:29 INFO - "revision": "a07ea7fb572f503761e11fdae02f6d0340f157ec", 21:29:29 INFO - "stage_platform": "linux64-pgo", 21:29:29 INFO - "builduid": "b1a84459b7194c67b2cbcefbec04f387", 21:29:29 INFO - "slavebuilddir": "test" 21:29:29 INFO - } 21:29:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:29:29 INFO - Running post-action listener: _resource_record_post_action 21:29:29 INFO - ##### 21:29:29 INFO - ##### Running download-and-extract step. 21:29:29 INFO - ##### 21:29:29 INFO - Running pre-action listener: _resource_record_pre_action 21:29:29 INFO - Running main action method: download_and_extract 21:29:29 INFO - mkdir: /builds/slave/test/build/tests 21:29: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')]} 21:29:29 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:29:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:29:39 INFO - Downloaded 1361 bytes. 21:29:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:29:39 INFO - Using the following test package requirements: 21:29:39 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:29:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:29:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:29:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'jsshell-linux-x86_64.zip'], 21:29:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:29:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:29:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:29:39 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:29:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:29:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:29:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:29:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:39 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:29:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:29:46 INFO - Downloaded 23857707 bytes. 21:29:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:29:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:29:48 INFO - Return code: 0 21:29:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:48 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:29:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:29:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:29:49 INFO - Downloaded 23857707 bytes. 21:29:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:29:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:29:51 INFO - Return code: 0 21:29: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')]} 21:29:51 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:29:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:29:52 INFO - Downloaded 10840145 bytes. 21:29:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:29:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:29:53 INFO - Return code: 0 21:29: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')]} 21:29:53 INFO - https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:29:56 INFO - Downloaded 58326869 bytes. 21:29:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:56 INFO - mkdir: /builds/slave/test/properties 21:29:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:29:56 INFO - Writing to file /builds/slave/test/properties/build_url 21:29:56 INFO - Contents: 21:29:56 INFO - build_url:https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:29:57 INFO - Running post-action listener: _resource_record_post_action 21:29:57 INFO - Running post-action listener: set_extra_try_arguments 21:29:57 INFO - ##### 21:29:57 INFO - ##### Running populate-webroot step. 21:29:57 INFO - ##### 21:29:57 INFO - Running pre-action listener: _resource_record_pre_action 21:29:57 INFO - Running main action method: populate_webroot 21:29:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:29:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:29:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:29:57 INFO - '--tppagecycles', 21:29:57 INFO - '7'], 21:29:57 INFO - 'tests': ['tsvgm']}}, 21:29:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:29:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:29:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:29:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:29:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:29:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['damp', 'tps']}, 21:29:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'tests': ['damp', 'tps']}, 21:29:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['dromaeo_dom']}, 21:29:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:29:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['a11yr', 21:29:57 INFO - 'ts_paint', 21:29:57 INFO - 'tpaint', 21:29:57 INFO - 'sessionrestore', 21:29:57 INFO - 'sessionrestore_no_auto_restore', 21:29:57 INFO - 'tabpaint']}, 21:29:57 INFO - 'other-e10s': {'tests': ['a11yr', 21:29:57 INFO - 'ts_paint', 21:29:57 INFO - 'tpaint', 21:29:57 INFO - 'sessionrestore', 21:29:57 INFO - 'sessionrestore_no_auto_restore', 21:29:57 INFO - 'tabpaint']}, 21:29:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:29:57 INFO - 'ts_paint', 21:29:57 INFO - 'tpaint', 21:29:57 INFO - 'sessionrestore', 21:29:57 INFO - 'sessionrestore_no_auto_restore', 21:29:57 INFO - 'tabpaint']}, 21:29:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:29:57 INFO - 'ts_paint', 21:29:57 INFO - 'tpaint', 21:29:57 INFO - 'sessionrestore', 21:29:57 INFO - 'sessionrestore_no_auto_restore', 21:29:57 INFO - 'tabpaint']}, 21:29:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['a11yr', 21:29:57 INFO - 'ts_paint', 21:29:57 INFO - 'tpaint', 21:29:57 INFO - 'sessionrestore', 21:29:57 INFO - 'sessionrestore_no_auto_restore', 21:29:57 INFO - 'tabpaint']}, 21:29:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['a11yr', 21:29:57 INFO - 'ts_paint', 21:29:57 INFO - 'tpaint', 21:29:57 INFO - 'sessionrestore', 21:29:57 INFO - 'sessionrestore_no_auto_restore', 21:29:57 INFO - 'tabpaint']}, 21:29:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['tsvgx', 21:29:57 INFO - 'tsvgr_opacity', 21:29:57 INFO - 'tart', 21:29:57 INFO - 'tscrollx', 21:29:57 INFO - 'cart']}, 21:29:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:29:57 INFO - 'tsvgr_opacity', 21:29:57 INFO - 'tart', 21:29:57 INFO - 'tscrollx', 21:29:57 INFO - 'cart']}, 21:29:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'talos_options': ['--disable-e10s'], 21:29:57 INFO - 'tests': ['tp5o']}, 21:29:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'tests': ['tp5o']}, 21:29:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'talos_options': ['--disable-e10s', 21:29:57 INFO - '--xperf_path', 21:29:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:57 INFO - 'tests': ['tp5n']}, 21:29:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:29:57 INFO - 'talos_options': ['--xperf_path', 21:29:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:29:57 INFO - 'tests': ['tp5n']}}, 21:29:57 INFO - 'talos.zip': {'path': '', 21:29:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:29:57 INFO - Running post-action listener: _resource_record_post_action 21:29:57 INFO - ##### 21:29:57 INFO - ##### Running create-virtualenv step. 21:29:57 INFO - ##### 21:29:57 INFO - Running pre-action listener: _resource_record_pre_action 21:29:57 INFO - Running main action method: create_virtualenv 21:29:57 INFO - Creating virtualenv /builds/slave/test/build/venv 21:29:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:29:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:29:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:29:57 INFO - Using real prefix '/usr' 21:29:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:29:58 INFO - Installing distribute.............................................................................................................................................................................................done. 21:30:00 INFO - Installing pip.................done. 21:30:00 INFO - Return code: 0 21:30:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:30:00 INFO - Using env: {'DISPLAY': ':0', 21:30:00 INFO - 'HOME': '/home/cltbld', 21:30:00 INFO - 'LANG': 'en_US.UTF-8', 21:30:00 INFO - 'LANGUAGE': 'en_US:en', 21:30:00 INFO - 'LOGNAME': 'cltbld', 21:30:00 INFO - 'MAIL': '/var/mail/cltbld', 21:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:00 INFO - 'MOZ_NO_REMOTE': '1', 21:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:00 INFO - 'NO_EM_RESTART': '1', 21:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:00 INFO - 'PWD': '/builds/slave/test', 21:30:00 INFO - 'SHELL': '/bin/bash', 21:30:00 INFO - 'SHLVL': '1', 21:30:00 INFO - 'TERM': 'linux', 21:30:00 INFO - 'TMOUT': '86400', 21:30:00 INFO - 'USER': 'cltbld', 21:30:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:00 INFO - '_': '/tools/buildbot/bin/python'} 21:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:30:00 INFO - Cleaning up... 21:30:00 INFO - Return code: 0 21:30:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:30:00 INFO - Using env: {'DISPLAY': ':0', 21:30:00 INFO - 'HOME': '/home/cltbld', 21:30:00 INFO - 'LANG': 'en_US.UTF-8', 21:30:00 INFO - 'LANGUAGE': 'en_US:en', 21:30:00 INFO - 'LOGNAME': 'cltbld', 21:30:00 INFO - 'MAIL': '/var/mail/cltbld', 21:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:00 INFO - 'MOZ_NO_REMOTE': '1', 21:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:00 INFO - 'NO_EM_RESTART': '1', 21:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:00 INFO - 'PWD': '/builds/slave/test', 21:30:00 INFO - 'SHELL': '/bin/bash', 21:30:00 INFO - 'SHLVL': '1', 21:30:00 INFO - 'TERM': 'linux', 21:30:00 INFO - 'TMOUT': '86400', 21:30:00 INFO - 'USER': 'cltbld', 21:30:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:00 INFO - '_': '/tools/buildbot/bin/python'} 21:30:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:00 INFO - Downloading/unpacking psutil>=0.7.1 21:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:30:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:02 INFO - Installing collected packages: psutil 21:30:02 INFO - Running setup.py install for psutil 21:30:02 INFO - building 'psutil._psutil_linux' extension 21:30:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:30:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:30:02 INFO - building 'psutil._psutil_posix' extension 21:30:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:30:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:30:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:03 INFO - Successfully installed psutil 21:30:03 INFO - Cleaning up... 21:30:03 INFO - Return code: 0 21:30:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:30:03 INFO - Using env: {'DISPLAY': ':0', 21:30:03 INFO - 'HOME': '/home/cltbld', 21:30:03 INFO - 'LANG': 'en_US.UTF-8', 21:30:03 INFO - 'LANGUAGE': 'en_US:en', 21:30:03 INFO - 'LOGNAME': 'cltbld', 21:30:03 INFO - 'MAIL': '/var/mail/cltbld', 21:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:03 INFO - 'MOZ_NO_REMOTE': '1', 21:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:03 INFO - 'NO_EM_RESTART': '1', 21:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:03 INFO - 'PWD': '/builds/slave/test', 21:30:03 INFO - 'SHELL': '/bin/bash', 21:30:03 INFO - 'SHLVL': '1', 21:30:03 INFO - 'TERM': 'linux', 21:30:03 INFO - 'TMOUT': '86400', 21:30:03 INFO - 'USER': 'cltbld', 21:30:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:03 INFO - '_': '/tools/buildbot/bin/python'} 21:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:30:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:30:05 INFO - Installing collected packages: mozsystemmonitor 21:30:05 INFO - Running setup.py install for mozsystemmonitor 21:30:05 INFO - Successfully installed mozsystemmonitor 21:30:05 INFO - Cleaning up... 21:30:05 INFO - Return code: 0 21:30:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:30:05 INFO - Using env: {'DISPLAY': ':0', 21:30:05 INFO - 'HOME': '/home/cltbld', 21:30:05 INFO - 'LANG': 'en_US.UTF-8', 21:30:05 INFO - 'LANGUAGE': 'en_US:en', 21:30:05 INFO - 'LOGNAME': 'cltbld', 21:30:05 INFO - 'MAIL': '/var/mail/cltbld', 21:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:05 INFO - 'MOZ_NO_REMOTE': '1', 21:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:05 INFO - 'NO_EM_RESTART': '1', 21:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:05 INFO - 'PWD': '/builds/slave/test', 21:30:05 INFO - 'SHELL': '/bin/bash', 21:30:05 INFO - 'SHLVL': '1', 21:30:05 INFO - 'TERM': 'linux', 21:30:05 INFO - 'TMOUT': '86400', 21:30:05 INFO - 'USER': 'cltbld', 21:30:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:05 INFO - '_': '/tools/buildbot/bin/python'} 21:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:30:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:30:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:08 INFO - Downloading docopt-0.6.1.tar.gz 21:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:30:08 INFO - Installing collected packages: blobuploader, requests, docopt 21:30:08 INFO - Running setup.py install for blobuploader 21:30:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:30:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:30:08 INFO - Running setup.py install for requests 21:30:08 INFO - Running setup.py install for docopt 21:30:08 INFO - Successfully installed blobuploader requests docopt 21:30:08 INFO - Cleaning up... 21:30:08 INFO - Return code: 0 21:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:08 INFO - Using env: {'DISPLAY': ':0', 21:30:08 INFO - 'HOME': '/home/cltbld', 21:30:08 INFO - 'LANG': 'en_US.UTF-8', 21:30:08 INFO - 'LANGUAGE': 'en_US:en', 21:30:08 INFO - 'LOGNAME': 'cltbld', 21:30:08 INFO - 'MAIL': '/var/mail/cltbld', 21:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:08 INFO - 'MOZ_NO_REMOTE': '1', 21:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:08 INFO - 'NO_EM_RESTART': '1', 21:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:08 INFO - 'PWD': '/builds/slave/test', 21:30:08 INFO - 'SHELL': '/bin/bash', 21:30:08 INFO - 'SHLVL': '1', 21:30:08 INFO - 'TERM': 'linux', 21:30:08 INFO - 'TMOUT': '86400', 21:30:08 INFO - 'USER': 'cltbld', 21:30:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:08 INFO - '_': '/tools/buildbot/bin/python'} 21:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:09 INFO - Running setup.py (path:/tmp/pip-4vdDQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:09 INFO - Running setup.py (path:/tmp/pip-UqhmrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:09 INFO - Running setup.py (path:/tmp/pip-kgy3Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:09 INFO - Running setup.py (path:/tmp/pip-lmVUsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:09 INFO - Running setup.py (path:/tmp/pip-F7fqHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:09 INFO - Running setup.py (path:/tmp/pip-misqY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:09 INFO - Running setup.py (path:/tmp/pip-Fvgwgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:09 INFO - Running setup.py (path:/tmp/pip-7Wn3Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:09 INFO - Running setup.py (path:/tmp/pip-sFRDod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:09 INFO - Running setup.py (path:/tmp/pip-Sx0O1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:09 INFO - Running setup.py (path:/tmp/pip-VU8sNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:09 INFO - Running setup.py (path:/tmp/pip-RwCsGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:09 INFO - Running setup.py (path:/tmp/pip-NbmLLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:10 INFO - Running setup.py (path:/tmp/pip-SiPaBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:10 INFO - Running setup.py (path:/tmp/pip-DobWaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:10 INFO - Running setup.py (path:/tmp/pip-jxvDsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:10 INFO - Running setup.py (path:/tmp/pip-tkbBHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:30:10 INFO - Running setup.py install for manifestparser 21:30:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:30:10 INFO - Running setup.py install for mozcrash 21:30:10 INFO - Running setup.py install for mozdebug 21:30:10 INFO - Running setup.py install for mozdevice 21:30:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:30:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:30:10 INFO - Running setup.py install for mozfile 21:30:10 INFO - Running setup.py install for mozhttpd 21:30:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:30:10 INFO - Running setup.py install for mozinfo 21:30:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Running setup.py install for mozInstall 21:30:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Running setup.py install for mozleak 21:30:11 INFO - Running setup.py install for mozlog 21:30:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Running setup.py install for moznetwork 21:30:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Running setup.py install for mozprocess 21:30:11 INFO - Running setup.py install for mozprofile 21:30:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Running setup.py install for mozrunner 21:30:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:30:11 INFO - Running setup.py install for mozscreenshot 21:30:11 INFO - Running setup.py install for moztest 21:30:11 INFO - Running setup.py install for mozversion 21:30:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:30:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:30:12 INFO - Cleaning up... 21:30:12 INFO - Return code: 0 21:30:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:12 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')]} 21:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:12 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')]} 21:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:12 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 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:12 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 21:30:12 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 21:30:12 INFO - Using env: {'DISPLAY': ':0', 21:30:12 INFO - 'HOME': '/home/cltbld', 21:30:12 INFO - 'LANG': 'en_US.UTF-8', 21:30:12 INFO - 'LANGUAGE': 'en_US:en', 21:30:12 INFO - 'LOGNAME': 'cltbld', 21:30:12 INFO - 'MAIL': '/var/mail/cltbld', 21:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:12 INFO - 'MOZ_NO_REMOTE': '1', 21:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:12 INFO - 'NO_EM_RESTART': '1', 21:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:12 INFO - 'PWD': '/builds/slave/test', 21:30:12 INFO - 'SHELL': '/bin/bash', 21:30:12 INFO - 'SHLVL': '1', 21:30:12 INFO - 'TERM': 'linux', 21:30:12 INFO - 'TMOUT': '86400', 21:30:12 INFO - 'USER': 'cltbld', 21:30:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:12 INFO - '_': '/tools/buildbot/bin/python'} 21:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:12 INFO - Running setup.py (path:/tmp/pip-EDPYVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:12 INFO - Running setup.py (path:/tmp/pip-0Lixiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:12 INFO - Running setup.py (path:/tmp/pip-DTv1TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:12 INFO - Running setup.py (path:/tmp/pip-hSJTLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:12 INFO - Running setup.py (path:/tmp/pip-lm6Hb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:12 INFO - Running setup.py (path:/tmp/pip-ANji_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:12 INFO - Running setup.py (path:/tmp/pip-oGQeSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:12 INFO - Running setup.py (path:/tmp/pip-ftfxuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:12 INFO - Running setup.py (path:/tmp/pip-pAUSvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:30:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:12 INFO - Running setup.py (path:/tmp/pip-FOygJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:13 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)) 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:13 INFO - Running setup.py (path:/tmp/pip-PgrWwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:13 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)) 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:13 INFO - Running setup.py (path:/tmp/pip-U2udAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:13 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)) 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:13 INFO - Running setup.py (path:/tmp/pip-noJTj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:13 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)) 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:13 INFO - Running setup.py (path:/tmp/pip-ai_C1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:13 INFO - Running setup.py (path:/tmp/pip-TtyIaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:13 INFO - Running setup.py (path:/tmp/pip-3P7XOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:13 INFO - Running setup.py (path:/tmp/pip-AZpCbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:30:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:15 INFO - Downloading blessings-1.6.tar.gz 21:30:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:30:15 INFO - Installing collected packages: blessings 21:30:15 INFO - Running setup.py install for blessings 21:30:15 INFO - Successfully installed blessings 21:30:15 INFO - Cleaning up... 21:30:15 INFO - Return code: 0 21:30:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:30:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:15 INFO - Reading from file tmpfile_stdout 21:30:15 INFO - Current package versions: 21:30:15 INFO - argparse == 1.2.1 21:30:15 INFO - blessings == 1.6 21:30:15 INFO - blobuploader == 1.2.4 21:30:15 INFO - docopt == 0.6.1 21:30:15 INFO - manifestparser == 1.1 21:30:15 INFO - mozInstall == 1.12 21:30:15 INFO - mozcrash == 0.17 21:30:15 INFO - mozdebug == 0.1 21:30:15 INFO - mozdevice == 0.48 21:30:15 INFO - mozfile == 1.2 21:30:15 INFO - mozhttpd == 0.7 21:30:15 INFO - mozinfo == 0.9 21:30:15 INFO - mozleak == 0.1 21:30:15 INFO - mozlog == 3.1 21:30:15 INFO - moznetwork == 0.27 21:30:15 INFO - mozprocess == 0.22 21:30:15 INFO - mozprofile == 0.28 21:30:15 INFO - mozrunner == 6.11 21:30:15 INFO - mozscreenshot == 0.1 21:30:15 INFO - mozsystemmonitor == 0.0 21:30:15 INFO - moztest == 0.7 21:30:15 INFO - mozversion == 1.4 21:30:15 INFO - psutil == 3.1.1 21:30:15 INFO - requests == 1.2.3 21:30:15 INFO - wsgiref == 0.1.2 21:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:30:15 INFO - Using env: {'DISPLAY': ':0', 21:30:15 INFO - 'HOME': '/home/cltbld', 21:30:15 INFO - 'LANG': 'en_US.UTF-8', 21:30:15 INFO - 'LANGUAGE': 'en_US:en', 21:30:15 INFO - 'LOGNAME': 'cltbld', 21:30:15 INFO - 'MAIL': '/var/mail/cltbld', 21:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:15 INFO - 'MOZ_NO_REMOTE': '1', 21:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:15 INFO - 'NO_EM_RESTART': '1', 21:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:15 INFO - 'PWD': '/builds/slave/test', 21:30:15 INFO - 'SHELL': '/bin/bash', 21:30:15 INFO - 'SHLVL': '1', 21:30:15 INFO - 'TERM': 'linux', 21:30:15 INFO - 'TMOUT': '86400', 21:30:15 INFO - 'USER': 'cltbld', 21:30:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:15 INFO - '_': '/tools/buildbot/bin/python'} 21:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 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)) 21:30:16 INFO - Cleaning up... 21:30:16 INFO - Return code: 0 21:30:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:30:16 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')]} 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:16 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')]} 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:16 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 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:16 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 21:30:16 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 21:30:16 INFO - Using env: {'DISPLAY': ':0', 21:30:16 INFO - 'HOME': '/home/cltbld', 21:30:16 INFO - 'LANG': 'en_US.UTF-8', 21:30:16 INFO - 'LANGUAGE': 'en_US:en', 21:30:16 INFO - 'LOGNAME': 'cltbld', 21:30:16 INFO - 'MAIL': '/var/mail/cltbld', 21:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:16 INFO - 'MOZ_NO_REMOTE': '1', 21:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:16 INFO - 'NO_EM_RESTART': '1', 21:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:16 INFO - 'PWD': '/builds/slave/test', 21:30:16 INFO - 'SHELL': '/bin/bash', 21:30:16 INFO - 'SHLVL': '1', 21:30:16 INFO - 'TERM': 'linux', 21:30:16 INFO - 'TMOUT': '86400', 21:30:16 INFO - 'USER': 'cltbld', 21:30:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:16 INFO - '_': '/tools/buildbot/bin/python'} 21:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:16 INFO - Downloading/unpacking jsonschema 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:30:18 INFO - Downloading/unpacking functools32 (from jsonschema) 21:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:30:18 INFO - warning: no files found matching '*.txt' 21:30:18 INFO - no previously-included directories found matching 'build' 21:30:18 INFO - no previously-included directories found matching 'dist' 21:30:18 INFO - no previously-included directories found matching '.git*' 21:30:18 INFO - Installing collected packages: jsonschema, functools32 21:30:18 INFO - Running setup.py install for functools32 21:30:18 INFO - warning: no files found matching '*.txt' 21:30:18 INFO - no previously-included directories found matching 'build' 21:30:18 INFO - no previously-included directories found matching 'dist' 21:30:18 INFO - no previously-included directories found matching '.git*' 21:30:18 INFO - Successfully installed jsonschema functools32 21:30:18 INFO - Cleaning up... 21:30:18 INFO - Return code: 0 21:30:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd09ababf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x281c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e75a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, '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': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', '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 21:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 21:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:30:18 INFO - Using env: {'DISPLAY': ':0', 21:30:18 INFO - 'HOME': '/home/cltbld', 21:30:18 INFO - 'LANG': 'en_US.UTF-8', 21:30:18 INFO - 'LANGUAGE': 'en_US:en', 21:30:18 INFO - 'LOGNAME': 'cltbld', 21:30:18 INFO - 'MAIL': '/var/mail/cltbld', 21:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:18 INFO - 'MOZ_NO_REMOTE': '1', 21:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:18 INFO - 'NO_EM_RESTART': '1', 21:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:18 INFO - 'PWD': '/builds/slave/test', 21:30:18 INFO - 'SHELL': '/bin/bash', 21:30:18 INFO - 'SHLVL': '1', 21:30:18 INFO - 'TERM': 'linux', 21:30:18 INFO - 'TMOUT': '86400', 21:30:18 INFO - 'USER': 'cltbld', 21:30:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:18 INFO - '_': '/tools/buildbot/bin/python'} 21:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:18 INFO - Downloading/unpacking flake8 21:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:30:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:30:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:30:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:30:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:30:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:30:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:30:21 INFO - no previously-included directories found matching 'docs/_build' 21:30:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:30:21 INFO - Running setup.py install for pep8 21:30:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:30:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:30:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:30:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:30:21 INFO - no previously-included directories found matching 'docs/_build' 21:30:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:30:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:30:21 INFO - Cleaning up... 21:30:21 INFO - Return code: 0 21:30:21 INFO - Running post-action listener: _resource_record_post_action 21:30:21 INFO - Running post-action listener: _start_resource_monitoring 21:30:21 INFO - Starting resource monitoring. 21:30:21 INFO - ##### 21:30:21 INFO - ##### Running install step. 21:30:21 INFO - ##### 21:30:21 INFO - Running pre-action listener: _resource_record_pre_action 21:30:21 INFO - Running main action method: install 21:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:21 INFO - Reading from file tmpfile_stdout 21:30:21 INFO - Detecting whether we're running mozinstall >=1.0... 21:30:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:30:22 INFO - Reading from file tmpfile_stdout 21:30:22 INFO - Output received: 21:30:22 INFO - Usage: mozinstall [options] installer 21:30:22 INFO - Options: 21:30:22 INFO - -h, --help show this help message and exit 21:30:22 INFO - -d DEST, --destination=DEST 21:30:22 INFO - Directory to install application into. [default: 21:30:22 INFO - "/builds/slave/test"] 21:30:22 INFO - --app=APP Application being installed. [default: firefox] 21:30:22 INFO - mkdir: /builds/slave/test/build/application 21:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:30:38 INFO - Reading from file tmpfile_stdout 21:30:38 INFO - Output received: 21:30:38 INFO - /builds/slave/test/build/application/firefox/firefox 21:30:38 INFO - Running post-action listener: _resource_record_post_action 21:30:38 INFO - ##### 21:30:38 INFO - ##### Running run-tests step. 21:30:38 INFO - ##### 21:30:38 INFO - Running pre-action listener: _resource_record_pre_action 21:30:38 INFO - Running main action method: run_tests 21:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:30:38 INFO - Python 2.7.3 21:30:38 INFO - Return code: 0 21:30:38 INFO - grabbing minidump binary from tooltool 21:30: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')]} 21:30:38 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 0x2976410>, '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 0x2977310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29777a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:30:38 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 21:30:38 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 21:30:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:30:38 INFO - Return code: 0 21:30:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:30:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:30:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:30:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:30:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:30:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:30:39 INFO - Return code: 0 21:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:30:39 INFO - Using env: {'DISPLAY': ':0', 21:30:39 INFO - 'HOME': '/home/cltbld', 21:30:39 INFO - 'LANG': 'en_US.UTF-8', 21:30:39 INFO - 'LANGUAGE': 'en_US:en', 21:30:39 INFO - 'LOGNAME': 'cltbld', 21:30:39 INFO - 'MAIL': '/var/mail/cltbld', 21:30:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:30:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:39 INFO - 'MOZ_NO_REMOTE': '1', 21:30:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:39 INFO - 'NO_EM_RESTART': '1', 21:30:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:39 INFO - 'PWD': '/builds/slave/test', 21:30:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:30:39 INFO - 'SHELL': '/bin/bash', 21:30:39 INFO - 'SHLVL': '1', 21:30:39 INFO - 'TERM': 'linux', 21:30:39 INFO - 'TMOUT': '86400', 21:30:39 INFO - 'USER': 'cltbld', 21:30:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922', 21:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:39 INFO - '_': '/tools/buildbot/bin/python'} 21:30:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:30:39 INFO - mozversion application_buildid: 20160424182636 21:30:39 INFO - mozversion application_changeset: a07ea7fb572f503761e11fdae02f6d0340f157ec 21:30:39 INFO - mozversion application_display_name: Nightly 21:30:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:30:39 INFO - mozversion application_name: Firefox 21:30:39 INFO - mozversion application_remotingname: firefox 21:30:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:30:39 INFO - mozversion application_vendor: Mozilla 21:30:39 INFO - mozversion application_version: 48.0a1 21:30:39 INFO - mozversion platform_buildid: 20160424182636 21:30:39 INFO - mozversion platform_changeset: a07ea7fb572f503761e11fdae02f6d0340f157ec 21:30:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:30:39 INFO - mozversion platform_version: 48.0a1 21:30:39 INFO - using testdate: 1461558639 21:30:39 INFO - actual date: 1461558639 21:30:39 INFO - starting webserver on 'localhost:54756' 21:30:39 INFO - SUITE-START | Running 2 tests 21:30:39 INFO - TEST-START | dromaeo_css 21:30:39 INFO - operating with platform_type : linux_ 21:30:39 INFO - Initialising browser for dromaeo_css test... 21:30:39 INFO - TEST-INFO | started process 21458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpym66ow/profile http://localhost:54756/getInfo.html) 21:30:43 INFO - PROCESS | 21458 | 21:30:43 INFO - PROCESS | 21458 | (process:21530): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:30:44 INFO - PROCESS | 21458 | __metrics Screen width/height:1600/1200 21:30:44 INFO - PROCESS | 21458 | colorDepth:24 21:30:44 INFO - PROCESS | 21458 | Browser inner width/height: 1024/697 21:30:44 INFO - PROCESS | 21458 | __metrics 21:30:44 ERROR - PROCESS | 21458 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:30:45 INFO - TEST-INFO | 21458: exit 0 21:30:45 INFO - Browser initialized. 21:30:45 INFO - Running cycle 1/1 for dromaeo_css test... 21:30:45 INFO - TEST-INFO | started process 21581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpym66ow/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:47 INFO - PROCESS | 21581 | 21:30:47 INFO - PROCESS | 21581 | (process:21644): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:30:57 INFO - PROCESS | 21581 | RSS: Main: 164417536 21:30:57 INFO - PROCESS | 21581 | 21:31:47 INFO - PROCESS | 21581 | 1461558707000 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] 21:33:54 INFO - PROCESS | 21581 | Cycle 1(1): loaded http://localhost:54756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54756/tests/dromaeo/cssquery-ext.html) 21:33:55 INFO - PROCESS | 21581 | RSS: Main: 169099264 21:33:55 INFO - PROCESS | 21581 | 21:36:57 INFO - PROCESS | 21581 | Cycle 1(1): loaded http://localhost:54756/tests/dromaeo/cssquery-ext.html (next: http://localhost:54756/tests/dromaeo/cssquery-jquery.html) 21:36:58 INFO - PROCESS | 21581 | RSS: Main: 166989824 21:36:58 INFO - PROCESS | 21581 | 21:39:59 INFO - PROCESS | 21581 | Cycle 1(1): loaded http://localhost:54756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54756/tests/dromaeo/cssquery-mootools.html) 21:40:00 INFO - PROCESS | 21581 | RSS: Main: 167014400 21:40:00 INFO - PROCESS | 21581 | 21:43:02 INFO - PROCESS | 21581 | Cycle 1(1): loaded http://localhost:54756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54756/tests/dromaeo/cssquery-prototype.html) 21:43:02 INFO - PROCESS | 21581 | RSS: Main: 164876288 21:43:02 INFO - PROCESS | 21581 | 21:46:05 INFO - PROCESS | 21581 | Cycle 1(1): loaded http://localhost:54756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54756/tests/dromaeo/cssquery-yui.html) 21:46:05 INFO - PROCESS | 21581 | RSS: Main: 166539264 21:46:05 INFO - PROCESS | 21581 | 21:49:07 INFO - PROCESS | 21581 | Cycle 1(1): loaded http://localhost:54756/tests/dromaeo/cssquery-yui.html (next: http://localhost:54756/tests/dromaeo/cssquery-dojo.html) 21:49:08 INFO - PROCESS | 21581 | RSS: Main: 168288256 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | __start_tp_report 21:49:08 INFO - PROCESS | 21581 | _x_x_mozilla_page_load 21:49:08 INFO - PROCESS | 21581 | _x_x_mozilla_page_load_details 21:49:08 INFO - PROCESS | 21581 | |i|pagename|runs| 21:49:08 INFO - PROCESS | 21581 | |0;dojo.html;3135.937281254375;3196.296814700766;3202.1674364665164;3226.951595726066;3230.4185246655593;5331.173668081448;5354.946450535494;5391.676499410029;5395.622306438551;5464.26232458618;5294.549963253128;5400.945990540094;5430.456954304567;5450.781968721256;5504.587155963299;4829.492903245153;4853.466118726938;4904.386951631046;4932.8026878924975;4956.281339205813;553.4382289976671;4817.759112044384;4846.612271018328;4890.682105663138;4894.97552512237;4861;4869.659123861314;4880.6095512358925;4906.386701662293;4919.72941488218;4880.609551235928;4909.7790599423115;4910.607151427877;4915.311856340115;4951.579115775164;4826.0347930414055;4876.195427754416;4925.852224433237;4937.654364194508;4976.975115124437;5284.233786101032;5326.893462130774;5329.920051199235;5346.97326513365;5404.973055119554;5679.687617181054;5814.186013958049;5821.941780582182;5832.6792026438525;5850.561207909382;5827.3007239131575;5844.678542680151;5867.647941123503;5871.970640146772;5897.705114744245;5426.538744206747;5431.755570999275;5437.619366644337;5445.918311225335;5450.809221677222;5897.351291357947;5934.940650593525;5949.464548190597;5950.137230101611;5957;5742.454466825645;5785.768569257182;5786.94213057864;5793.913091303634;5830.970845145832;5851.093080572518;5855.736491857877;5856.94143058564;5869.618474799125;5873.2658417697785;5696.686682232517;5755.884882302331;5800.8259752207505;5816.389279125716;5836.883262334814;5820.563457740686;5830.76676932918;5831.212786273799;5846;5855.063189889597;4299.720518166309;4359.302511598129;4379.890502737457;4385.451818522684;4401.801918913657;3884.514435695538;3912;3967.543732470745;3981.3629819229363;4017.216642754693;5484.396716361197;5485.122380419114;5539.833804985857;5541.196526503634;5609.8597535061135;5848.795292164754;5896.911546326808;5897.144913987534;5899.557533185029;5900.232969713909;5506.091494903296;5541.667499950016;5579.525740312038;5642.294713160855;5644.491995720405;5002.395879087963;5009.874753131128;5010.674306170087;5011.724355160502;5029.220470827027;6063.636181829104;6067.089936509559;6070.089486576961;6079.118527813443;6108.5418593605655;5799.159121927212;5835.270591176103;5874.441928016831;5887.293524777054;5922.052471604523;5987.2815262168815;5989.880202395841;5998.3401825798255;6003.729832157476;6004.87990240184;5624;5656.123300888369;5677.318721753416;5694.003549378925;5713.542916566747;5827.096799996008;5878.118282257696;5880.294364676266;5895.7052147393315;5919.289685237799;5628.380878103323;5658.632188907708;5660.377358490645;5665.915011274752;5669.121286200645;5609.4390560943575;5623.746931388179;5655.123455864347;5667.3765885753355;5696.174054762119;5634.887302254014;5642.85892852682;5674.4892959633835;5677.432256774289;5703.315602127771;5725.656460612377;5733.913991290051;5760.308762948473;5775.422457754191;5780.421957804186;5490.752916118704;5584.218209450599;5647.463490968352;5649.661020338793;5664.631798933056 21:49:08 INFO - PROCESS | 21581 | |1;ext.html;590.3653572409657;634.6763150793096;639.066962235137;647.792706333973;674.5817593092283;38569.22861542767;39375.40936885949;39645.801770991144;39697.40453893186;39767.801160994226;40013;40767.184656306854;40805.38791918124;40824.387634185514;40911;8604.268637165833;8790.956045219766;8882.93404791426;8888.422252553595;8888.466691998468;8494.74515764528;8665.870011949826;8674.262687671524;8678.783030424258;8680.826383472328;8582.313414926792;8658.393912426132;8693.261072808818;8697.95651021744;8720.12798720126;8605.655773769073;8621.741347759546;8653.653853845839;8664;8706.521141337224;8676.089010653854;8687.087855775178;8787.077356877564;8812.471251724917;8815.162559556897;40911.59088409108;41097;41174.58825411738;41224.79387603073;41267;2906.636670416198;3187.474066778979;3214.4856822908455;3306.8842590509216;3421.1105112670884;27811;27839;28090;28112.156635300973;28149.29626759327;4094.242565125461;4121.8969525762095;4151.169766046773;4156.114483954901;4283.378910058055;197522;199483;199855;201605;202802.9859850706;34752.826235868655;34886.476702849475;34987.82506087504;35032.29935401278;35077.824610877295;65127;65923.67038164874;66541;66651.66674166598;66732.66633666898;14017.229052402216;14101.78847317291;14139.717205655828;14148.858511414754;14255;11196.608118715969;11279.379634120201;11291.774164516828;11295;11309.434528273554;18981.33565325207;19063.61872762537;19121.330753423565;19670.311539096063;19801.504962376057;7070.186928503185;7080.893786593205;7199.524097559987;7267.418606511466;7342.5227360221415;983.0759086458706;1027.2141811514198;1128.9225590897145;1132.824412216108;1181.7990941539958;31135.532967005514;31738.523922141187;32047.679523204468;32439.837800810845;32470.188245293582;1093.670481873604;1094.934303941766;1119.4850368830266;1119.92720473169;1188.1089183112665;15135.772963405558;15196.164210968282;15263.618409539627;15419.151946643042;15623.843761562466;334467;341702;346288;350356;350589;57834.71082644644;58944.41055589475;59496;59717.701411492664;59894;1403.5789263220993;1406.923703366925;1426.3652674559721;1432.0405328429977;1432.6490009947422;30136.84931575328;32368.190795229366;32751.48461400101;33121.668783311856;34960.475592865616;55377.44622553723;56989.71505142448;57022.14466782918;57101.42898570961;57219.42780572308;333279;334373;334882;336135;338261;40918.38622420726;40978.1804363917;41371.58628413677;41428;41505.58494415138;49660.29586005843;50942.490575093776;51052.74473627608;51597.226041610156;51856;40654.186916260915;41789.37315940203;42415.7879210602;42959.78520107379;43372.56627433685;41986.580134198266;42190.367144492244;42410.57589424066;42581.787091065584;43073;35959.10102247465;41705.79147104245;41721.582784172984;43142.78428607837;43718.56281437272;31574.842125789222;33308.833455833534;33421.33157336888;33579.16052098717;33585.32829343448;25947.610785838606;27127.72872271252;27969.300767480974;28270.85864570664;28348.57477137886 21:49:08 INFO - PROCESS | 21581 | |2;jquery.html;384.75568014310903;388.093800974724;391.5731852281013;399.9240144372569;407.0881226053639;14401.711965760678;17051.658966820658;17812.821871781278;18321.908390458048;18340.082995850204;17336.913315433405;17665.20506577204;17903.283868645238;17942.19260133294;17942.461726148238;5402.297701298826;5575.637583557076;5714.1428785682065;5741.655500669973;5786.363500014995;5661.971690141543;5679.176519404684;6646.302138275484;7084.220735719066;7104.36060754532;6848.965755171217;7010.088688470491;7067.328603782658;7421.183669796318;7426.368758655493;7175.928240717631;7321;7343.04540409746;7393.70425182992;7395.112586489602;7150.5352152109945;7171.856562868714;7181.066461360042;7206.17129030163;7220.494565380425;23709.407264818346;24871.87564062168;26137.215883523524;26408.73591264082;26485.47029059408;2479.219046000522;2626.3828000419885;2731.6312297839736;2787.818791778548;3070.9712246397485;15445.922770386076;16006.359745610162;16176.676466470723;16335.509934701979;16479.505614831574;1999.1203870297022;2003.5492014296813;2026.9391918242477;2097.192580856366;2169.9783002170093;94683;97031.99999999929;97539;98155;100013.4999325006;16801;17491.212895419736;17630.559236018944;17747.46757597274;17798.46604601864;14176.858231417555;15031.774523382159;32083.51874721881;32283.67716322807;32421.18947026296;7619.923800762032;7634.549435607217;7812.765617031499;7964.601769911481;7974.122846486882;7500.099988001366;7638.732644357532;7679.116901556281;7709.4603377763015;7748.380129589619;4586.587207151372;4659.487456379796;4669.276262179367;4669.39297891272;4707.764611769398;1943.687012455202;1950.3076407875283;1973.9111739971736;1985.7390556996122;2035.297822251321;914.7027216154777;937.2501998401252;945.8392073347547;1016.9677777056294;1031.2265800649513;17269.654606907792;17375.913120434318;18254.26982920668;19081.141348639343;19350.225990960487;983.6016413352604;996.6113215845826;1008.2941940641433;1022.2895087913829;1028.619410818002;10288.639897603547;10549.947250263853;10586.258961872749;10617.84073238902;10645.254832161829;414581;435505;448286;452732;452768;88696.556517217;88989;89915;90497.54751226201;92114;1015.4871789746279;1033.2199189611945;1049.842523621463;1058.5818601652304;1061.8672665916915;15315.923420382827;16424.343026278813;16485.093319867523;16669.249883755503;16769.832301676826;27228.371176899578;35357;35682.46476302909;36583.08542286358;37104.44343334798;45537.77231113823;48111.51888481071;48746;49694.50305497043;54403.18395224154;8490.660373585235;8535.231829135408;8728.607212675572;8780.604872780868;8791.252743516872;9493.762655933657;13211.66970825737;13315.334233288491;13434.059615826798;13443.731125377242;11575.42122893835;11853.940730296294;11958.402079896145;12020;12315.398998130186;11450.484728187084;11769.176157669224;12060.095492837896;12063.034957203578;12221.755564888475;11741.589044383747;11775.705607359885;11954.402279885797;12221.266723996589;12260.632181034583;8268.875966860382;8627.352948529011;8749.387542871938;8771.38600297973;8806.779830504032;10816.134709223401;11495.885041149815;11733.35466549348;11792.29246245228;11819.763604727685 21:49:08 INFO - PROCESS | 21581 | |3;mootools.html;1502.9849701502985;1528.732471817432;1684.7304431290995;1788.7227479740645;1818.1000404799627;7678.155402905676;8169.91830081699;8308.252257296843;8463.195996380342;8465.957670211648;8215.055268644108;8283.29591984682;8317.91682083179;8363.163683631634;8385.454945428542;2304.331743794302;2304.9654255186188;2334.6498025296255;2336.030547322859;2338.473843385233;2251.594712951668;2273.4884650953486;2278.692376529172;2296.2996286132807;2302.574023805593;2267.240474441064;2268.3648578398074;2275.52214035052;2297.1270917051497;2319.3042087373806;2213.369189780921;2218.157100301883;2229.6098182818023;2232;2233.3076746208644;2223.666450032492;2224.443889027743;2227.4208705736464;2229.2197730794255;2234.6424572068554;8409.327253819742;8526.147385261485;8534.317254619615;8538.658453661908;8550.52972086535;5038.496150384969;5179.766910488999;5180.041692286902;5180.704823794052;5181.4300426953005;3292.1440425489304;3420.794752314844;3487.616362200156;3520.1551627609447;3539.2744487380023;1186.7626474705094;1201.0451690905752;1224.871388504212;1258.0627432562708;1271.161033717742;11613.76772464546;11619.07047436203;11650.067994560415;11675.241109327952;11713.70715732105;4401.537838526972;4413.955860441354;4451.154280686724;4559.498455169929;4585.908281834345;9837.458939758239;9847.359921605215;9874.654387096418;9896.059874311928;9918.107370336704;5084.3644544431945;5097.235414687752;5100.846974590768;5128.692278463304;5130.538251557377;4351.325544540601;4711.963368059021;4783.402074740658;4868.464468908417;4925.827596034122;3859.517560304962;3882.4176373544196;3966.9801650991562;4003.319435695939;4033.69747268956;1245.9003279737599;1284.4926254129566;1286.4403984266687;1295.5530342031984;1302.3358087375318;816;906.5467266366817;974.4786539201635;980.3823591137538;1014.518103900656;5634.718264086861;5768.74040668171;5880.764769409261;5959.374265702126;5982.970085149546;457.86721850662934;459.9517050709627;462.9166749985035;468.42383867842744;485.7886819233645;4209;4268.978655106766;4272.9359059614135;4277.422547955986;4277.486701595828;10175.135113515285;10448.68653940383;10569.471526423647;10623.990720881658;10669.679909602724;10511.1591072714;10529.789404211873;10543.525541350658;10546.419946902994;10547.261691681662;7625.23747625233;7922.326602238759;7958.164392738679;7972.123066462685;7992.600369981477;5785.8553536161935;5897.9115313271195;5974.850628734316;5993.280806303272;6035.909461358171;9367.391119577205;9380.3902746324;9404.858927116236;9484.668036618685;9538.713838584854;9374.468893398607;9448.433094014381;9501.952490237505;9546.713598592054;9561.474118923526;6996.510244283055;7289.671964761705;7515.436342274461;7628.084629844454;7659.080910290801;8183.918160818315;8191.754247372588;8196.180381961756;8222;8273.627686753991;7302.233265507045;7335.083114610674;7346.77959661211;7352.926470735438;7601.277878601524;7140.428765698835;7214.098237720285;7339.816504587428;7341;7451.664675089743;6974.058502102152;6985.336393042653;7001.159860816734;7029.824254393681;7046.4715146363205;5059;5254.500822421864;5267.394249661184;5318.867028324323;5392.946070539245;5154.690718556899;5187.636865419385;5189.82984900408;5204.141316682856;5274.077036518671 21:49:08 INFO - PROCESS | 21581 | |4;prototype.html;327.6085078331392;331.74787161757064;336.2317105414129;338.93729660012895;342.51021039912916;5868.325142608602;5909.468147866691;5951.31559870615;6006.309274433442;6053.2130822993;5977.103434484829;5979.4319539643775;5989.125219894442;6014.18864908074;6017.51859851212;4564.8174073037035;4568.84009059683;4579.580330097664;4580.885477863047;4588.793504292298;4446.688731788776;4566.132434837386;4622.1217968586025;4629.305604159386;4629.930551041737;4502.977485112569;4537.614302784251;4569.177548041352;4571.062932098928;4577.633789296865;4536.637069034469;4540.68215224936;4578.35902973584;4596.448426188846;4604.654650901196;3714.60996595359;3883.4757407684947;3886.591907849663;4075.9796201018803;4079.8164082616354;5767.971160144214;5786.363500015037;5795.391483894215;5805.564582656318;5806.535477161817;5197.1424714922;5229.2156176573435;5275;5280.445553216895;5288.497592728685;5954.374790646963;6298.244210694746;6299.622022678654;6334.556581039329;6352;4352.499462561783;4355.194289056535;4360.498542667602;4379.255526560492;4381.75900325482;6273.843153921142;6487.416132548094;6630.535862489628;6636.502262330297;6684.9331506685285;4412.558744125626;4427.512973572904;4447.62195213404;4457.910841783211;4475.977620111878;4473.2842745160615;4486.8109950863045;4514.7291162530355;4515.7967891444305;4516.345129956138;4994.925076123861;5222.3472065991755;5225.503577160163;5230.816921407809;5275.736213189325;6209.441150296495;6287.842803929847;6299.496040316763;6368.395002474757;6429.9678501607195;1625.7805196298584;1642.6714657068635;1644.843739844713;1647.3081305851572;1648.332425367728;1069.4652673663168;1103.4041617526607;1103.5420300575172;1114;1118.9608363707232;6111.755529778848;6127.172831667668;6130.386961303834;6142.754289828356;6182.258129024456;6529.771457998947;6560.343965603402;6608.339166083353;6622.63575503352;6629.535932484776;5968.492678122321;6064.514838812885;6096.847578810476;6105.694715264219;6117.938820611826;3458.4466485362723;3492.842822073013;3501.457274122515;3505.4741788731894;3505.807180605091;6561.540692151503;6723.5293529452465;6764.323567643295;6787.966060169668;6803.115594972721;6582.637954912526;6621.470282377399;6653;6653.966730166415;6677.332266773381;6575.1069529406905;6738.696758645872;6758.256591774901;6786.287439818847;6800.489963252776;6520.152380190734;6549.410553050248;6556.18047744032;6558.311377305505;6558.737650493927;6357.93642063592;6430.549861509649;6446;6451.870962580629;6484.319146489551;6728.932710672831;6738.73045078211;6760.932390676227;6783.321667833177;6785.728570857111;4590.495045545054;4624.630029597692;4629.560191781776;4629.60648344881;4641.327007583949;6251.812445626639;6410.391012853772;6492.415682588401;6558.639274839929;6595.934040659532;6358.523110766619;6366.77716279928;6367.713452894538;6381.361863813581;6396.616203027833;6246.938020536429;6425.807225783234;6442.677866106769;6459.321771213955;6461.483081353386;6237.695989767046;6252.437280644764;6294.3076261612105;6326.778562750282;6330.556861019684;6447.743889335856;6453.45145662624;6465.806025819233;6479.352064793483;6490;6223.517610009525;6225.875482490415;6330.335314791881;6340.841478962879;6371.55399122057 21:49:08 INFO - PROCESS | 21581 | |5;yui.html;760.4676726291598;793.1632128104849;815.955122468264;824.0646865807307;849.1635738797283;13993.51022714204;14121.43514259431;14201.502947396843;14320.570382888503;14437.783433248496;13316.733665326688;13329.266890321029;13362;13384.063115581914;13450.663733406669;675.5811396933908;783.3889566138392;787.3897729259841;800.0599295827379;805.2712295372697;803.6865622407266;807.2169995104739;808.2725547007682;809.3080416244114;810.2545657994659;844.8690452979798;845.3068483843251;846.6401779243828;847.4110493207223;862.5040601654042;848.4103548034119;850.817074329016;853.1937319233327;853.3173461231021;862.3575436299965;613.3804857094323;613.5858295650418;615.2954866677629;616.9136320915076;618.0080970043061;12793.61619151427;12798.744025119538;12811.807822882663;12833.550825721148;12857.035722320863;14109.929450352682;14154.36305366261;14331.355089021019;14367.425302987867;14516;11201.327920324806;11364.204505684605;11430.314181149157;11539.59611413605;11657.242279251821;3869.8645547405704;3896.980515097435;3942.743721658083;4052.7770972596495;4067.145899361108;51692;51871;53708.19437708437;54263.91472170574;54450.727746361015;11221.551137954553;11278.718032049264;11320.320780753182;11420.714482137846;11517.48171332292;19818.70271945922;20060.996950152436;20252.898735506227;20287.594248114954;20575.279865204648;8170.182981701902;8185.467944583583;8230.93136085253;8274.379421543288;8441.788955276044;4371.693981421334;4459.554044595515;4510.954890451119;4542.159700455426;4550.294704320836;3478.513008178857;3500.212452198235;3511.894643160709;3522.7181825453904;3531.4879342495196;627.9026750853534;631.2614241337646;647.297682015019;647.3397134922353;706.6925887239067;636.4526507203801;691.218922617439;694.9965250173717;704.5068452083563;751.8872169174558;9084.18242358191;9399.610213984633;9458.290628202913;9510.191633711074;9720;588.5938702295402;676.2594958520413;708.1749761527865;714.4463041143156;716.0583832260561;4376.868693939187;4527.479339875957;4599.885002874888;4600;4648.953510464919;60419.39580604226;61004.694976524836;61148.082778758355;65724.34275657278;65889;56843.715781420826;57485.425145748006;57667.13499297514;58085;58272;51395.229071563954;52497.737511312196;53003.20495192575;53047.20429193488;54245.72877135589;9443.527823608929;9654.420734755937;9717.12545870875;9764.170045546209;9789.118979291898;33272.33455330928;33854.492182616785;34371.65628343785;34463.13842153966;34466.138346541535;43611.56388436075;46712;47032.29451558161;48247.75876120597;48519.51480485291;12122.575709850113;12171.39143042862;12360.567380141652;12406.193597416139;12725.872741272839;13788.310584470937;13970.860291396955;13975.231362275172;14206.502772402917;14539.20034398076;13064.934675326562;13254.801177982145;13569.864301357255;13733.862661373258;13872.861271387157;13589.116707413987;13663.316834158451;13768.311584420939;13809.102408343426;13878.653033674238;13250.668733281746;13403.32983350848;13454.663633409244;13636.250006249751;13651.38568764388;11161;11209.887901120885;11352.659420217407;11580.420978951188;11737.589184378507;11220.438978050901;11608.825867612162;11667.183297169116;11791.941040294743;11844.407779611158 21:49:08 INFO - PROCESS | 21581 | __end_tp_report 21:49:08 INFO - PROCESS | 21581 | __start_cc_report 21:49:08 INFO - PROCESS | 21581 | _x_x_mozilla_cycle_collect,352 21:49:08 INFO - PROCESS | 21581 | __end_cc_report 21:49:08 INFO - PROCESS | 21581 | __startTimestamp1461559748234__endTimestamp 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | ------- Summary: start ------- 21:49:08 INFO - PROCESS | 21581 | Number of tests: 6 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | [#0] dojo.html Cycles:165 Average:5376.15 Median:5644.49 stddev:729.90 (12.9%) stddev-sans-first:710.67 21:49:08 INFO - PROCESS | 21581 | Values: 3135.9 3196.3 3202.2 3227.0 3230.4 5331.2 5354.9 5391.7 5395.6 5464.3 5294.5 5400.9 5430.5 5450.8 5504.6 4829.5 4853.5 4904.4 4932.8 4956.3 553.4 4817.8 4846.6 4890.7 4895.0 4861.0 4869.7 4880.6 4906.4 4919.7 4880.6 4909.8 4910.6 4915.3 4951.6 4826.0 4876.2 4925.9 4937.7 4977.0 5284.2 5326.9 5329.9 5347.0 5405.0 5679.7 5814.2 5821.9 5832.7 5850.6 5827.3 5844.7 5867.6 5872.0 5897.7 5426.5 5431.8 5437.6 5445.9 5450.8 5897.4 5934.9 5949.5 5950.1 5957.0 5742.5 5785.8 5786.9 5793.9 5831.0 5851.1 5855.7 5856.9 5869.6 5873.3 5696.7 5755.9 5800.8 5816.4 5836.9 5820.6 5830.8 5831.2 5846.0 5855.1 4299.7 4359.3 4379.9 4385.5 4401.8 3884.5 3912.0 3967.5 3981.4 4017.2 5484.4 5485.1 5539.8 5541.2 5609.9 5848.8 5896.9 5897.1 5899.6 5900.2 5506.1 5541.7 5579.5 5642.3 5644.5 5002.4 5009.9 5010.7 5011.7 5029.2 6063.6 6067.1 6070.1 6079.1 6108.5 5799.2 5835.3 5874.4 5887.3 5922.1 5987.3 5989.9 5998.3 6003.7 6004.9 5624.0 5656.1 5677.3 5694.0 5713.5 5827.1 5878.1 5880.3 5895.7 5919.3 5628.4 5658.6 5660.4 5665.9 5669.1 5609.4 5623.7 5655.1 5667.4 5696.2 5634.9 5642.9 5674.5 5677.4 5703.3 5725.7 5733.9 5760.3 5775.4 5780.4 5490.8 5584.2 5647.5 5649.7 5664.6 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | [#1] ext.html Cycles:180 Average:47568.69 Median:40333.59 stddev:78911.55 (195.6%) stddev-sans-first:79054.08 21:49:08 INFO - PROCESS | 21581 | Values: 590.4 634.7 639.1 647.8 674.6 38569.2 39375.4 39645.8 39697.4 39767.8 40013.0 40767.2 40805.4 40824.4 40911.0 8604.3 8791.0 8882.9 8888.4 8888.5 8494.7 8665.9 8674.3 8678.8 8680.8 8582.3 8658.4 8693.3 8698.0 8720.1 8605.7 8621.7 8653.7 8664.0 8706.5 8676.1 8687.1 8787.1 8812.5 8815.2 40911.6 41097.0 41174.6 41224.8 41267.0 2906.6 3187.5 3214.5 3306.9 3421.1 27811.0 27839.0 28090.0 28112.2 28149.3 4094.2 4121.9 4151.2 4156.1 4283.4 197522.0 199483.0 199855.0 201605.0 202803.0 34752.8 34886.5 34987.8 35032.3 35077.8 65127.0 65923.7 66541.0 66651.7 66732.7 14017.2 14101.8 14139.7 14148.9 14255.0 11196.6 11279.4 11291.8 11295.0 11309.4 18981.3 19063.6 19121.3 19670.3 19801.5 7070.2 7080.9 7199.5 7267.4 7342.5 983.1 1027.2 1128.9 1132.8 1181.8 31135.5 31738.5 32047.7 32439.8 32470.2 1093.7 1094.9 1119.5 1119.9 1188.1 15135.8 15196.2 15263.6 15419.2 15623.8 334467.0 341702.0 346288.0 350356.0 350589.0 57834.7 58944.4 59496.0 59717.7 59894.0 1403.6 1406.9 1426.4 1432.0 1432.6 30136.8 32368.2 32751.5 33121.7 34960.5 55377.4 56989.7 57022.1 57101.4 57219.4 333279.0 334373.0 334882.0 336135.0 338261.0 40918.4 40978.2 41371.6 41428.0 41505.6 49660.3 50942.5 51052.7 51597.2 51856.0 40654.2 41789.4 42415.8 42959.8 43372.6 41986.6 42190.4 42410.6 42581.8 43073.0 35959.1 41705.8 41721.6 43142.8 43718.6 31574.8 33308.8 33421.3 33579.2 33585.3 25947.6 27127.7 27969.3 28270.9 28348.6 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | [#2] jquery.html Cycles:180 Average:28269.37 Median:2759.73 stddev:73135.95 (2650.1%) stddev-sans-first:73311.14 21:49:08 INFO - PROCESS | 21581 | Values: 384.8 388.1 391.6 399.9 407.1 14401.7 17051.7 17812.8 18321.9 18340.1 17336.9 17665.2 17903.3 17942.2 17942.5 5402.3 5575.6 5714.1 5741.7 5786.4 5662.0 5679.2 6646.3 7084.2 7104.4 6849.0 7010.1 7067.3 7421.2 7426.4 7175.9 7321.0 7343.0 7393.7 7395.1 7150.5 7171.9 7181.1 7206.2 7220.5 23709.4 24871.9 26137.2 26408.7 26485.5 2479.2 2626.4 2731.6 2787.8 3071.0 15445.9 16006.4 16176.7 16335.5 16479.5 1999.1 2003.5 2026.9 2097.2 2170.0 94683.0 97032.0 97539.0 98155.0 100013.5 16801.0 17491.2 17630.6 17747.5 17798.5 14176.9 15031.8 32083.5 32283.7 32421.2 7619.9 7634.5 7812.8 7964.6 7974.1 7500.1 7638.7 7679.1 7709.5 7748.4 4586.6 4659.5 4669.3 4669.4 4707.8 1943.7 1950.3 1973.9 1985.7 2035.3 914.7 937.3 945.8 1017.0 1031.2 17269.7 17375.9 18254.3 19081.1 19350.2 983.6 996.6 1008.3 1022.3 1028.6 10288.6 10549.9 10586.3 10617.8 10645.3 414581.0 435505.0 448286.0 452732.0 452768.0 88696.6 88989.0 89915.0 90497.5 92114.0 1015.5 1033.2 1049.8 1058.6 1061.9 15315.9 16424.3 16485.1 16669.2 16769.8 27228.4 35357.0 35682.5 36583.1 37104.4 45537.8 48111.5 48746.0 49694.5 54403.2 8490.7 8535.2 8728.6 8780.6 8791.3 9493.8 13211.7 13315.3 13434.1 13443.7 11575.4 11853.9 11958.4 12020.0 12315.4 11450.5 11769.2 12060.1 12063.0 12221.8 11741.6 11775.7 11954.4 12221.3 12260.6 8268.9 8627.4 8749.4 8771.4 8806.8 10816.1 11495.9 11733.4 11792.3 11819.8 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | [#3] mootools.html Cycles:180 Average:5612.35 Median:5114.77 stddev:3119.75 (61.0%) stddev-sans-first:3113.21 21:49:08 INFO - PROCESS | 21581 | Values: 1503.0 1528.7 1684.7 1788.7 1818.1 7678.2 8169.9 8308.3 8463.2 8466.0 8215.1 8283.3 8317.9 8363.2 8385.5 2304.3 2305.0 2334.6 2336.0 2338.5 2251.6 2273.5 2278.7 2296.3 2302.6 2267.2 2268.4 2275.5 2297.1 2319.3 2213.4 2218.2 2229.6 2232.0 2233.3 2223.7 2224.4 2227.4 2229.2 2234.6 8409.3 8526.1 8534.3 8538.7 8550.5 5038.5 5179.8 5180.0 5180.7 5181.4 3292.1 3420.8 3487.6 3520.2 3539.3 1186.8 1201.0 1224.9 1258.1 1271.2 11613.8 11619.1 11650.1 11675.2 11713.7 4401.5 4414.0 4451.2 4559.5 4585.9 9837.5 9847.4 9874.7 9896.1 9918.1 5084.4 5097.2 5100.8 5128.7 5130.5 4351.3 4712.0 4783.4 4868.5 4925.8 3859.5 3882.4 3967.0 4003.3 4033.7 1245.9 1284.5 1286.4 1295.6 1302.3 816.0 906.5 974.5 980.4 1014.5 5634.7 5768.7 5880.8 5959.4 5983.0 457.9 460.0 462.9 468.4 485.8 4209.0 4269.0 4272.9 4277.4 4277.5 10175.1 10448.7 10569.5 10624.0 10669.7 10511.2 10529.8 10543.5 10546.4 10547.3 7625.2 7922.3 7958.2 7972.1 7992.6 5785.9 5897.9 5974.9 5993.3 6035.9 9367.4 9380.4 9404.9 9484.7 9538.7 9374.5 9448.4 9502.0 9546.7 9561.5 6996.5 7289.7 7515.4 7628.1 7659.1 8183.9 8191.8 8196.2 8222.0 8273.6 7302.2 7335.1 7346.8 7352.9 7601.3 7140.4 7214.1 7339.8 7341.0 7451.7 6974.1 6985.3 7001.2 7029.8 7046.5 5059.0 5254.5 5267.4 5318.9 5392.9 5154.7 5187.6 5189.8 5204.1 5274.1 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | [#4] prototype.html Cycles:180 Average:5304.13 Median:6035.37 stddev:1597.10 (26.5%) stddev-sans-first:1557.29 21:49:08 INFO - PROCESS | 21581 | Values: 327.6 331.7 336.2 338.9 342.5 5868.3 5909.5 5951.3 6006.3 6053.2 5977.1 5979.4 5989.1 6014.2 6017.5 4564.8 4568.8 4579.6 4580.9 4588.8 4446.7 4566.1 4622.1 4629.3 4629.9 4503.0 4537.6 4569.2 4571.1 4577.6 4536.6 4540.7 4578.4 4596.4 4604.7 3714.6 3883.5 3886.6 4076.0 4079.8 5768.0 5786.4 5795.4 5805.6 5806.5 5197.1 5229.2 5275.0 5280.4 5288.5 5954.4 6298.2 6299.6 6334.6 6352.0 4352.5 4355.2 4360.5 4379.3 4381.8 6273.8 6487.4 6630.5 6636.5 6684.9 4412.6 4427.5 4447.6 4457.9 4476.0 4473.3 4486.8 4514.7 4515.8 4516.3 4994.9 5222.3 5225.5 5230.8 5275.7 6209.4 6287.8 6299.5 6368.4 6430.0 1625.8 1642.7 1644.8 1647.3 1648.3 1069.5 1103.4 1103.5 1114.0 1119.0 6111.8 6127.2 6130.4 6142.8 6182.3 6529.8 6560.3 6608.3 6622.6 6629.5 5968.5 6064.5 6096.8 6105.7 6117.9 3458.4 3492.8 3501.5 3505.5 3505.8 6561.5 6723.5 6764.3 6788.0 6803.1 6582.6 6621.5 6653.0 6654.0 6677.3 6575.1 6738.7 6758.3 6786.3 6800.5 6520.2 6549.4 6556.2 6558.3 6558.7 6357.9 6430.5 6446.0 6451.9 6484.3 6728.9 6738.7 6760.9 6783.3 6785.7 4590.5 4624.6 4629.6 4629.6 4641.3 6251.8 6410.4 6492.4 6558.6 6595.9 6358.5 6366.8 6367.7 6381.4 6396.6 6246.9 6425.8 6442.7 6459.3 6461.5 6237.7 6252.4 6294.3 6326.8 6330.6 6447.7 6453.5 6465.8 6479.4 6490.0 6223.5 6225.9 6330.3 6340.8 6371.6 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - PROCESS | 21581 | [#5] yui.html Cycles:180 Average:15165.66 Median:4534.82 stddev:17444.57 (384.7%) stddev-sans-first:17459.97 21:49:08 INFO - PROCESS | 21581 | Values: 760.5 793.2 816.0 824.1 849.2 13993.5 14121.4 14201.5 14320.6 14437.8 13316.7 13329.3 13362.0 13384.1 13450.7 675.6 783.4 787.4 800.1 805.3 803.7 807.2 808.3 809.3 810.3 844.9 845.3 846.6 847.4 862.5 848.4 850.8 853.2 853.3 862.4 613.4 613.6 615.3 616.9 618.0 12793.6 12798.7 12811.8 12833.6 12857.0 14109.9 14154.4 14331.4 14367.4 14516.0 11201.3 11364.2 11430.3 11539.6 11657.2 3869.9 3897.0 3942.7 4052.8 4067.1 51692.0 51871.0 53708.2 54263.9 54450.7 11221.6 11278.7 11320.3 11420.7 11517.5 19818.7 20061.0 20252.9 20287.6 20575.3 8170.2 8185.5 8230.9 8274.4 8441.8 4371.7 4459.6 4511.0 4542.2 4550.3 3478.5 3500.2 3511.9 3522.7 3531.5 627.9 631.3 647.3 647.3 706.7 636.5 691.2 695.0 704.5 751.9 9084.2 9399.6 9458.3 9510.2 9720.0 588.6 676.3 708.2 714.4 716.1 4376.9 4527.5 4599.9 4600.0 4649.0 60419.4 61004.7 61148.1 65724.3 65889.0 56843.7 57485.4 57667.1 58085.0 58272.0 51395.2 52497.7 53003.2 53047.2 54245.7 9443.5 9654.4 9717.1 9764.2 9789.1 33272.3 33854.5 34371.7 34463.1 34466.1 43611.6 46712.0 47032.3 48247.8 48519.5 12122.6 12171.4 12360.6 12406.2 12725.9 13788.3 13970.9 13975.2 14206.5 14539.2 13064.9 13254.8 13569.9 13733.9 13872.9 13589.1 13663.3 13768.3 13809.1 13878.7 13250.7 13403.3 13454.7 13636.3 13651.4 11161.0 11209.9 11352.7 11580.4 11737.6 11220.4 11608.8 11667.2 11791.9 11844.4 21:49:08 INFO - PROCESS | 21581 | -------- Summary: end -------- 21:49:08 INFO - PROCESS | 21581 | 21:49:08 INFO - TEST-INFO | 21581: exit 0 21:49:08 INFO - TEST-OK | dromaeo_css | took 1109182ms 21:49:08 INFO - TEST-START | kraken 21:49:08 INFO - operating with platform_type : linux_ 21:49:08 INFO - Initialising browser for kraken test... 21:49:08 INFO - TEST-INFO | started process 21813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdy2TJY/profile http://localhost:54756/getInfo.html) 21:49:12 INFO - PROCESS | 21813 | 21:49:12 INFO - PROCESS | 21813 | (process:21880): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:49:13 INFO - PROCESS | 21813 | __metrics Screen width/height:1600/1200 21:49:13 INFO - PROCESS | 21813 | colorDepth:24 21:49:13 INFO - PROCESS | 21813 | Browser inner width/height: 1024/697 21:49:13 INFO - PROCESS | 21813 | __metrics 21:49:14 ERROR - PROCESS | 21813 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:49:14 INFO - TEST-INFO | 21813: exit 0 21:49:14 INFO - Browser initialized. 21:49:14 INFO - Running cycle 1/1 for kraken test... 21:49:14 INFO - TEST-INFO | started process 21931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdy2TJY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:16 INFO - PROCESS | 21931 | 21:49:16 INFO - PROCESS | 21931 | (process:21993): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 21:49:26 INFO - PROCESS | 21931 | RSS: Main: 164458496 21:49:26 INFO - PROCESS | 21931 | 21:49:29 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54756/tests/kraken/driver.html?testName=audio-beat-detection) 21:49:30 INFO - PROCESS | 21931 | RSS: Main: 168980480 21:49:30 INFO - PROCESS | 21931 | 21:49:32 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54756/tests/kraken/driver.html?testName=audio-dft) 21:49:33 INFO - PROCESS | 21931 | RSS: Main: 172158976 21:49:33 INFO - PROCESS | 21931 | 21:49:36 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54756/tests/kraken/driver.html?testName=audio-fft) 21:49:36 INFO - PROCESS | 21931 | RSS: Main: 162680832 21:49:36 INFO - PROCESS | 21931 | 21:49:39 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54756/tests/kraken/driver.html?testName=audio-oscillator) 21:49:39 INFO - PROCESS | 21931 | RSS: Main: 163848192 21:49:39 INFO - PROCESS | 21931 | 21:49:41 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:49:42 INFO - PROCESS | 21931 | RSS: Main: 164638720 21:49:42 INFO - PROCESS | 21931 | 21:49:45 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54756/tests/kraken/driver.html?testName=imaging-darkroom) 21:49:46 INFO - PROCESS | 21931 | RSS: Main: 165150720 21:49:46 INFO - PROCESS | 21931 | 21:49:49 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54756/tests/kraken/driver.html?testName=imaging-desaturate) 21:49:50 INFO - PROCESS | 21931 | RSS: Main: 167219200 21:49:50 INFO - PROCESS | 21931 | 21:49:53 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54756/tests/kraken/driver.html?testName=json-parse-financial) 21:49:53 INFO - PROCESS | 21931 | RSS: Main: 167333888 21:49:53 INFO - PROCESS | 21931 | 21:49:55 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:49:55 INFO - PROCESS | 21931 | RSS: Main: 167235584 21:49:55 INFO - PROCESS | 21931 | 21:49:57 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:49:58 INFO - PROCESS | 21931 | RSS: Main: 167026688 21:49:58 INFO - PROCESS | 21931 | 21:50:00 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:50:00 INFO - PROCESS | 21931 | RSS: Main: 167559168 21:50:00 INFO - PROCESS | 21931 | 21:50:03 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:50:04 INFO - PROCESS | 21931 | RSS: Main: 168058880 21:50:04 INFO - PROCESS | 21931 | 21:50:06 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:50:07 INFO - PROCESS | 21931 | RSS: Main: 168050688 21:50:07 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | Cycle 1(1): loaded http://localhost:54756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54756/tests/kraken/driver.html?testName=ai-astar) 21:50:09 INFO - PROCESS | 21931 | RSS: Main: 169668608 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | __start_tp_report 21:50:09 INFO - PROCESS | 21931 | _x_x_mozilla_page_load 21:50:09 INFO - PROCESS | 21931 | _x_x_mozilla_page_load_details 21:50:09 INFO - PROCESS | 21931 | |i|pagename|runs| 21:50:09 INFO - PROCESS | 21931 | |0;ai-astar;111;107;113;110;114;125;112;111;111;113 21:50:09 INFO - PROCESS | 21931 | |1;audio-beat-detection;157;127;160;199;130;158;161;133;192;134 21:50:09 INFO - PROCESS | 21931 | |2;audio-dft;163;163;164;162;163;165;171;162;165;163 21:50:09 INFO - PROCESS | 21931 | |3;audio-fft;73;77;77;146;74;76;76;76;100;73 21:50:09 INFO - PROCESS | 21931 | |4;audio-oscillator;94;94;155;93;93;92;144;93;92;157 21:50:09 INFO - PROCESS | 21931 | |5;imaging-gaussian-blur;118;119;118;118;118;118;117;118;117;118 21:50:09 INFO - PROCESS | 21931 | |6;imaging-darkroom;146;147;148;148;148;147;148;147;148;147 21:50:09 INFO - PROCESS | 21931 | |7;imaging-desaturate;95;96;96;95;96;95;96;100;95;94 21:50:09 INFO - PROCESS | 21931 | |8;json-parse-financial;62;57;63;57;56;56;56;71;54;60 21:50:09 INFO - PROCESS | 21931 | |9;json-stringify-tinderbox;61;61;63;62;61;62;61;61;62;61 21:50:09 INFO - PROCESS | 21931 | |10;stanford-crypto-aes;76;77;79;79;79;79;78;77;79;78 21:50:09 INFO - PROCESS | 21931 | |11;stanford-crypto-ccm;131;127;137;136;134;129;132;126;177;137 21:50:09 INFO - PROCESS | 21931 | |12;stanford-crypto-pbkdf2;170;176;167;169;174;167;173;168;174;167 21:50:09 INFO - PROCESS | 21931 | |13;stanford-crypto-sha256-iterative;70;72;68;69;71;72;68;69;68;77 21:50:09 INFO - PROCESS | 21931 | __end_tp_report 21:50:09 INFO - PROCESS | 21931 | __start_cc_report 21:50:09 INFO - PROCESS | 21931 | _x_x_mozilla_cycle_collect,822 21:50:09 INFO - PROCESS | 21931 | __end_cc_report 21:50:09 INFO - PROCESS | 21931 | __startTimestamp1461559809591__endTimestamp 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | ------- Summary: start ------- 21:50:09 INFO - PROCESS | 21931 | Number of tests: 14 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.50 stddev:4.74 (4.2%) stddev-sans-first:4.99 21:50:09 INFO - PROCESS | 21931 | Values: 111.0 107.0 113.0 110.0 114.0 125.0 112.0 111.0 111.0 113.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:159.00 stddev:25.19 (15.8%) stddev-sans-first:26.71 21:50:09 INFO - PROCESS | 21931 | Values: 157.0 127.0 160.0 199.0 130.0 158.0 161.0 133.0 192.0 134.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.64 (1.6%) stddev-sans-first:2.77 21:50:09 INFO - PROCESS | 21931 | Values: 163.0 163.0 164.0 162.0 163.0 165.0 171.0 162.0 165.0 163.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:22.91 (30.2%) stddev-sans-first:23.90 21:50:09 INFO - PROCESS | 21931 | Values: 73.0 77.0 77.0 146.0 74.0 76.0 76.0 76.0 100.0 73.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:93.00 stddev:28.70 (30.9%) stddev-sans-first:29.80 21:50:09 INFO - PROCESS | 21931 | Values: 94.0 94.0 155.0 93.0 93.0 92.0 144.0 93.0 92.0 157.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 21:50:09 INFO - PROCESS | 21931 | Values: 118.0 119.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 21:50:09 INFO - PROCESS | 21931 | Values: 146.0 147.0 148.0 148.0 148.0 147.0 148.0 147.0 148.0 147.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.50 stddev:1.62 (1.7%) stddev-sans-first:1.69 21:50:09 INFO - PROCESS | 21931 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 100.0 95.0 94.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:58.50 stddev:5.05 (8.6%) stddev-sans-first:5.25 21:50:09 INFO - PROCESS | 21931 | Values: 62.0 57.0 63.0 57.0 56.0 56.0 56.0 71.0 54.0 60.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 21:50:09 INFO - PROCESS | 21931 | Values: 61.0 61.0 63.0 62.0 61.0 62.0 61.0 61.0 62.0 61.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:79.00 stddev:1.10 (1.4%) stddev-sans-first:0.87 21:50:09 INFO - PROCESS | 21931 | Values: 76.0 77.0 79.0 79.0 79.0 79.0 78.0 77.0 79.0 78.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:135.00 stddev:14.74 (10.9%) stddev-sans-first:15.49 21:50:09 INFO - PROCESS | 21931 | Values: 131.0 127.0 137.0 136.0 134.0 129.0 132.0 126.0 177.0 137.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.50 stddev:3.44 (2.0%) stddev-sans-first:3.64 21:50:09 INFO - PROCESS | 21931 | Values: 170.0 176.0 167.0 169.0 174.0 167.0 173.0 168.0 174.0 167.0 21:50:09 INFO - PROCESS | 21931 | 21:50:09 INFO - PROCESS | 21931 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.80 (4.0%) stddev-sans-first:2.96 21:50:09 INFO - PROCESS | 21931 | Values: 70.0 72.0 68.0 69.0 71.0 72.0 68.0 69.0 68.0 77.0 21:50:09 INFO - PROCESS | 21931 | -------- Summary: end -------- 21:50:09 INFO - PROCESS | 21931 | 21:50:10 INFO - TEST-INFO | 21931: exit 0 21:50:10 INFO - TEST-OK | kraken | took 61555ms 21:50:10 INFO - SUITE-END | took 1170s 21:50:10 INFO - Completed test suite (00:19:30) 21:50:10 INFO - javascript benchmark 21:50:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.937281254375, 3196.296814700766, 3202.1674364665164, 3226.951595726066, 3230.4185246655593, 5331.173668081448, 5354.946450535494, 5391.676499410029, 5395.622306438551, 5464.26232458618, 5294.549963253128, 5400.945990540094, 5430.456954304567, 5450.781968721256, 5504.587155963299, 4829.492903245153, 4853.466118726938, 4904.386951631046, 4932.8026878924975, 4956.281339205813, 553.4382289976671, 4817.759112044384, 4846.612271018328, 4890.682105663138, 4894.97552512237, 4861.0, 4869.659123861314, 4880.6095512358925, 4906.386701662293, 4919.72941488218, 4880.609551235928, 4909.7790599423115, 4910.607151427877, 4915.311856340115, 4951.579115775164, 4826.0347930414055, 4876.195427754416, 4925.852224433237, 4937.654364194508, 4976.975115124437, 5284.233786101032, 5326.893462130774, 5329.920051199235, 5346.97326513365, 5404.973055119554, 5679.687617181054, 5814.186013958049, 5821.941780582182, 5832.6792026438525, 5850.561207909382, 5827.3007239131575, 5844.678542680151, 5867.647941123503, 5871.970640146772, 5897.705114744245, 5426.538744206747, 5431.755570999275, 5437.619366644337, 5445.918311225335, 5450.809221677222, 5897.351291357947, 5934.940650593525, 5949.464548190597, 5950.137230101611, 5957.0, 5742.454466825645, 5785.768569257182, 5786.94213057864, 5793.913091303634, 5830.970845145832, 5851.093080572518, 5855.736491857877, 5856.94143058564, 5869.618474799125, 5873.2658417697785, 5696.686682232517, 5755.884882302331, 5800.8259752207505, 5816.389279125716, 5836.883262334814, 5820.563457740686, 5830.76676932918, 5831.212786273799, 5846.0, 5855.063189889597, 4299.720518166309, 4359.302511598129, 4379.890502737457, 4385.451818522684, 4401.801918913657, 3884.514435695538, 3912.0, 3967.543732470745, 3981.3629819229363, 4017.216642754693, 5484.396716361197, 5485.122380419114, 5539.833804985857, 5541.196526503634, 5609.8597535061135, 5848.795292164754, 5896.911546326808, 5897.144913987534, 5899.557533185029, 5900.232969713909, 5506.091494903296, 5541.667499950016, 5579.525740312038, 5642.294713160855, 5644.491995720405, 5002.395879087963, 5009.874753131128, 5010.674306170087, 5011.724355160502, 5029.220470827027, 6063.636181829104, 6067.089936509559, 6070.089486576961, 6079.118527813443, 6108.5418593605655, 5799.159121927212, 5835.270591176103, 5874.441928016831, 5887.293524777054, 5922.052471604523, 5987.2815262168815, 5989.880202395841, 5998.3401825798255, 6003.729832157476, 6004.87990240184, 5624.0, 5656.123300888369, 5677.318721753416, 5694.003549378925, 5713.542916566747, 5827.096799996008, 5878.118282257696, 5880.294364676266, 5895.7052147393315, 5919.289685237799, 5628.380878103323, 5658.632188907708, 5660.377358490645, 5665.915011274752, 5669.121286200645, 5609.4390560943575, 5623.746931388179, 5655.123455864347, 5667.3765885753355, 5696.174054762119, 5634.887302254014, 5642.85892852682, 5674.4892959633835, 5677.432256774289, 5703.315602127771, 5725.656460612377, 5733.913991290051, 5760.308762948473, 5775.422457754191, 5780.421957804186, 5490.752916118704, 5584.218209450599, 5647.463490968352, 5649.661020338793, 5664.631798933056], "value": 5327.9902313174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3653572409657, 634.6763150793096, 639.066962235137, 647.792706333973, 674.5817593092283, 38569.22861542767, 39375.40936885949, 39645.801770991144, 39697.40453893186, 39767.801160994226, 40013.0, 40767.184656306854, 40805.38791918124, 40824.387634185514, 40911.0, 8604.268637165833, 8790.956045219766, 8882.93404791426, 8888.422252553595, 8888.466691998468, 8494.74515764528, 8665.870011949826, 8674.262687671524, 8678.783030424258, 8680.826383472328, 8582.313414926792, 8658.393912426132, 8693.261072808818, 8697.95651021744, 8720.12798720126, 8605.655773769073, 8621.741347759546, 8653.653853845839, 8664.0, 8706.521141337224, 8676.089010653854, 8687.087855775178, 8787.077356877564, 8812.471251724917, 8815.162559556897, 40911.59088409108, 41097.0, 41174.58825411738, 41224.79387603073, 41267.0, 2906.636670416198, 3187.474066778979, 3214.4856822908455, 3306.8842590509216, 3421.1105112670884, 27811.0, 27839.0, 28090.0, 28112.156635300973, 28149.29626759327, 4094.242565125461, 4121.8969525762095, 4151.169766046773, 4156.114483954901, 4283.378910058055, 197522.0, 199483.0, 199855.0, 201605.0, 202802.9859850706, 34752.826235868655, 34886.476702849475, 34987.82506087504, 35032.29935401278, 35077.824610877295, 65127.0, 65923.67038164874, 66541.0, 66651.66674166598, 66732.66633666898, 14017.229052402216, 14101.78847317291, 14139.717205655828, 14148.858511414754, 14255.0, 11196.608118715969, 11279.379634120201, 11291.774164516828, 11295.0, 11309.434528273554, 18981.33565325207, 19063.61872762537, 19121.330753423565, 19670.311539096063, 19801.504962376057, 7070.186928503185, 7080.893786593205, 7199.524097559987, 7267.418606511466, 7342.5227360221415, 983.0759086458706, 1027.2141811514198, 1128.9225590897145, 1132.824412216108, 1181.7990941539958, 31135.532967005514, 31738.523922141187, 32047.679523204468, 32439.837800810845, 32470.188245293582, 1093.670481873604, 1094.934303941766, 1119.4850368830266, 1119.92720473169, 1188.1089183112665, 15135.772963405558, 15196.164210968282, 15263.618409539627, 15419.151946643042, 15623.843761562466, 334467.0, 341702.0, 346288.0, 350356.0, 350589.0, 57834.71082644644, 58944.41055589475, 59496.0, 59717.701411492664, 59894.0, 1403.5789263220993, 1406.923703366925, 1426.3652674559721, 1432.0405328429977, 1432.6490009947422, 30136.84931575328, 32368.190795229366, 32751.48461400101, 33121.668783311856, 34960.475592865616, 55377.44622553723, 56989.71505142448, 57022.14466782918, 57101.42898570961, 57219.42780572308, 333279.0, 334373.0, 334882.0, 336135.0, 338261.0, 40918.38622420726, 40978.1804363917, 41371.58628413677, 41428.0, 41505.58494415138, 49660.29586005843, 50942.490575093776, 51052.74473627608, 51597.226041610156, 51856.0, 40654.186916260915, 41789.37315940203, 42415.7879210602, 42959.78520107379, 43372.56627433685, 41986.580134198266, 42190.367144492244, 42410.57589424066, 42581.787091065584, 43073.0, 35959.10102247465, 41705.79147104245, 41721.582784172984, 43142.78428607837, 43718.56281437272, 31574.842125789222, 33308.833455833534, 33421.33157336888, 33579.16052098717, 33585.32829343448, 25947.610785838606, 27127.72872271252, 27969.300767480974, 28270.85864570664, 28348.57477137886], "value": 19070.832408696497, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.75568014310903, 388.093800974724, 391.5731852281013, 399.9240144372569, 407.0881226053639, 14401.711965760678, 17051.658966820658, 17812.821871781278, 18321.908390458048, 18340.082995850204, 17336.913315433405, 17665.20506577204, 17903.283868645238, 17942.19260133294, 17942.461726148238, 5402.297701298826, 5575.637583557076, 5714.1428785682065, 5741.655500669973, 5786.363500014995, 5661.971690141543, 5679.176519404684, 6646.302138275484, 7084.220735719066, 7104.36060754532, 6848.965755171217, 7010.088688470491, 7067.328603782658, 7421.183669796318, 7426.368758655493, 7175.928240717631, 7321.0, 7343.04540409746, 7393.70425182992, 7395.112586489602, 7150.5352152109945, 7171.856562868714, 7181.066461360042, 7206.17129030163, 7220.494565380425, 23709.407264818346, 24871.87564062168, 26137.215883523524, 26408.73591264082, 26485.47029059408, 2479.219046000522, 2626.3828000419885, 2731.6312297839736, 2787.818791778548, 3070.9712246397485, 15445.922770386076, 16006.359745610162, 16176.676466470723, 16335.509934701979, 16479.505614831574, 1999.1203870297022, 2003.5492014296813, 2026.9391918242477, 2097.192580856366, 2169.9783002170093, 94683.0, 97031.99999999929, 97539.0, 98155.0, 100013.4999325006, 16801.0, 17491.212895419736, 17630.559236018944, 17747.46757597274, 17798.46604601864, 14176.858231417555, 15031.774523382159, 32083.51874721881, 32283.67716322807, 32421.18947026296, 7619.923800762032, 7634.549435607217, 7812.765617031499, 7964.601769911481, 7974.122846486882, 7500.099988001366, 7638.732644357532, 7679.116901556281, 7709.4603377763015, 7748.380129589619, 4586.587207151372, 4659.487456379796, 4669.276262179367, 4669.39297891272, 4707.764611769398, 1943.687012455202, 1950.3076407875283, 1973.9111739971736, 1985.7390556996122, 2035.297822251321, 914.7027216154777, 937.2501998401252, 945.8392073347547, 1016.9677777056294, 1031.2265800649513, 17269.654606907792, 17375.913120434318, 18254.26982920668, 19081.141348639343, 19350.225990960487, 983.6016413352604, 996.6113215845826, 1008.2941940641433, 1022.2895087913829, 1028.619410818002, 10288.639897603547, 10549.947250263853, 10586.258961872749, 10617.84073238902, 10645.254832161829, 414581.0, 435505.0, 448286.0, 452732.0, 452768.0, 88696.556517217, 88989.0, 89915.0, 90497.54751226201, 92114.0, 1015.4871789746279, 1033.2199189611945, 1049.842523621463, 1058.5818601652304, 1061.8672665916915, 15315.923420382827, 16424.343026278813, 16485.093319867523, 16669.249883755503, 16769.832301676826, 27228.371176899578, 35357.0, 35682.46476302909, 36583.08542286358, 37104.44343334798, 45537.77231113823, 48111.51888481071, 48746.0, 49694.50305497043, 54403.18395224154, 8490.660373585235, 8535.231829135408, 8728.607212675572, 8780.604872780868, 8791.252743516872, 9493.762655933657, 13211.66970825737, 13315.334233288491, 13434.059615826798, 13443.731125377242, 11575.42122893835, 11853.940730296294, 11958.402079896145, 12020.0, 12315.398998130186, 11450.484728187084, 11769.176157669224, 12060.095492837896, 12063.034957203578, 12221.755564888475, 11741.589044383747, 11775.705607359885, 11954.402279885797, 12221.266723996589, 12260.632181034583, 8268.875966860382, 8627.352948529011, 8749.387542871938, 8771.38600297973, 8806.779830504032, 10816.134709223401, 11495.885041149815, 11733.35466549348, 11792.29246245228, 11819.763604727685], "value": 9722.138185695994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.9849701502985, 1528.732471817432, 1684.7304431290995, 1788.7227479740645, 1818.1000404799627, 7678.155402905676, 8169.91830081699, 8308.252257296843, 8463.195996380342, 8465.957670211648, 8215.055268644108, 8283.29591984682, 8317.91682083179, 8363.163683631634, 8385.454945428542, 2304.331743794302, 2304.9654255186188, 2334.6498025296255, 2336.030547322859, 2338.473843385233, 2251.594712951668, 2273.4884650953486, 2278.692376529172, 2296.2996286132807, 2302.574023805593, 2267.240474441064, 2268.3648578398074, 2275.52214035052, 2297.1270917051497, 2319.3042087373806, 2213.369189780921, 2218.157100301883, 2229.6098182818023, 2232.0, 2233.3076746208644, 2223.666450032492, 2224.443889027743, 2227.4208705736464, 2229.2197730794255, 2234.6424572068554, 8409.327253819742, 8526.147385261485, 8534.317254619615, 8538.658453661908, 8550.52972086535, 5038.496150384969, 5179.766910488999, 5180.041692286902, 5180.704823794052, 5181.4300426953005, 3292.1440425489304, 3420.794752314844, 3487.616362200156, 3520.1551627609447, 3539.2744487380023, 1186.7626474705094, 1201.0451690905752, 1224.871388504212, 1258.0627432562708, 1271.161033717742, 11613.76772464546, 11619.07047436203, 11650.067994560415, 11675.241109327952, 11713.70715732105, 4401.537838526972, 4413.955860441354, 4451.154280686724, 4559.498455169929, 4585.908281834345, 9837.458939758239, 9847.359921605215, 9874.654387096418, 9896.059874311928, 9918.107370336704, 5084.3644544431945, 5097.235414687752, 5100.846974590768, 5128.692278463304, 5130.538251557377, 4351.325544540601, 4711.963368059021, 4783.402074740658, 4868.464468908417, 4925.827596034122, 3859.517560304962, 3882.4176373544196, 3966.9801650991562, 4003.319435695939, 4033.69747268956, 1245.9003279737599, 1284.4926254129566, 1286.4403984266687, 1295.5530342031984, 1302.3358087375318, 816.0, 906.5467266366817, 974.4786539201635, 980.3823591137538, 1014.518103900656, 5634.718264086861, 5768.74040668171, 5880.764769409261, 5959.374265702126, 5982.970085149546, 457.86721850662934, 459.9517050709627, 462.9166749985035, 468.42383867842744, 485.7886819233645, 4209.0, 4268.978655106766, 4272.9359059614135, 4277.422547955986, 4277.486701595828, 10175.135113515285, 10448.68653940383, 10569.471526423647, 10623.990720881658, 10669.679909602724, 10511.1591072714, 10529.789404211873, 10543.525541350658, 10546.419946902994, 10547.261691681662, 7625.23747625233, 7922.326602238759, 7958.164392738679, 7972.123066462685, 7992.600369981477, 5785.8553536161935, 5897.9115313271195, 5974.850628734316, 5993.280806303272, 6035.909461358171, 9367.391119577205, 9380.3902746324, 9404.858927116236, 9484.668036618685, 9538.713838584854, 9374.468893398607, 9448.433094014381, 9501.952490237505, 9546.713598592054, 9561.474118923526, 6996.510244283055, 7289.671964761705, 7515.436342274461, 7628.084629844454, 7659.080910290801, 8183.918160818315, 8191.754247372588, 8196.180381961756, 8222.0, 8273.627686753991, 7302.233265507045, 7335.083114610674, 7346.77959661211, 7352.926470735438, 7601.277878601524, 7140.428765698835, 7214.098237720285, 7339.816504587428, 7341.0, 7451.664675089743, 6974.058502102152, 6985.336393042653, 7001.159860816734, 7029.824254393681, 7046.4715146363205, 5059.0, 5254.500822421864, 5267.394249661184, 5318.867028324323, 5392.946070539245, 5154.690718556899, 5187.636865419385, 5189.82984900408, 5204.141316682856, 5274.077036518671], "value": 4469.431226233092, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6085078331392, 331.74787161757064, 336.2317105414129, 338.93729660012895, 342.51021039912916, 5868.325142608602, 5909.468147866691, 5951.31559870615, 6006.309274433442, 6053.2130822993, 5977.103434484829, 5979.4319539643775, 5989.125219894442, 6014.18864908074, 6017.51859851212, 4564.8174073037035, 4568.84009059683, 4579.580330097664, 4580.885477863047, 4588.793504292298, 4446.688731788776, 4566.132434837386, 4622.1217968586025, 4629.305604159386, 4629.930551041737, 4502.977485112569, 4537.614302784251, 4569.177548041352, 4571.062932098928, 4577.633789296865, 4536.637069034469, 4540.68215224936, 4578.35902973584, 4596.448426188846, 4604.654650901196, 3714.60996595359, 3883.4757407684947, 3886.591907849663, 4075.9796201018803, 4079.8164082616354, 5767.971160144214, 5786.363500015037, 5795.391483894215, 5805.564582656318, 5806.535477161817, 5197.1424714922, 5229.2156176573435, 5275.0, 5280.445553216895, 5288.497592728685, 5954.374790646963, 6298.244210694746, 6299.622022678654, 6334.556581039329, 6352.0, 4352.499462561783, 4355.194289056535, 4360.498542667602, 4379.255526560492, 4381.75900325482, 6273.843153921142, 6487.416132548094, 6630.535862489628, 6636.502262330297, 6684.9331506685285, 4412.558744125626, 4427.512973572904, 4447.62195213404, 4457.910841783211, 4475.977620111878, 4473.2842745160615, 4486.8109950863045, 4514.7291162530355, 4515.7967891444305, 4516.345129956138, 4994.925076123861, 5222.3472065991755, 5225.503577160163, 5230.816921407809, 5275.736213189325, 6209.441150296495, 6287.842803929847, 6299.496040316763, 6368.395002474757, 6429.9678501607195, 1625.7805196298584, 1642.6714657068635, 1644.843739844713, 1647.3081305851572, 1648.332425367728, 1069.4652673663168, 1103.4041617526607, 1103.5420300575172, 1114.0, 1118.9608363707232, 6111.755529778848, 6127.172831667668, 6130.386961303834, 6142.754289828356, 6182.258129024456, 6529.771457998947, 6560.343965603402, 6608.339166083353, 6622.63575503352, 6629.535932484776, 5968.492678122321, 6064.514838812885, 6096.847578810476, 6105.694715264219, 6117.938820611826, 3458.4466485362723, 3492.842822073013, 3501.457274122515, 3505.4741788731894, 3505.807180605091, 6561.540692151503, 6723.5293529452465, 6764.323567643295, 6787.966060169668, 6803.115594972721, 6582.637954912526, 6621.470282377399, 6653.0, 6653.966730166415, 6677.332266773381, 6575.1069529406905, 6738.696758645872, 6758.256591774901, 6786.287439818847, 6800.489963252776, 6520.152380190734, 6549.410553050248, 6556.18047744032, 6558.311377305505, 6558.737650493927, 6357.93642063592, 6430.549861509649, 6446.0, 6451.870962580629, 6484.319146489551, 6728.932710672831, 6738.73045078211, 6760.932390676227, 6783.321667833177, 6785.728570857111, 4590.495045545054, 4624.630029597692, 4629.560191781776, 4629.60648344881, 4641.327007583949, 6251.812445626639, 6410.391012853772, 6492.415682588401, 6558.639274839929, 6595.934040659532, 6358.523110766619, 6366.77716279928, 6367.713452894538, 6381.361863813581, 6396.616203027833, 6246.938020536429, 6425.807225783234, 6442.677866106769, 6459.321771213955, 6461.483081353386, 6237.695989767046, 6252.437280644764, 6294.3076261612105, 6326.778562750282, 6330.556861019684, 6447.743889335856, 6453.45145662624, 6465.806025819233, 6479.352064793483, 6490.0, 6223.517610009525, 6225.875482490415, 6330.335314791881, 6340.841478962879, 6371.55399122057], "value": 4787.411967889786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.4676726291598, 793.1632128104849, 815.955122468264, 824.0646865807307, 849.1635738797283, 13993.51022714204, 14121.43514259431, 14201.502947396843, 14320.570382888503, 14437.783433248496, 13316.733665326688, 13329.266890321029, 13362.0, 13384.063115581914, 13450.663733406669, 675.5811396933908, 783.3889566138392, 787.3897729259841, 800.0599295827379, 805.2712295372697, 803.6865622407266, 807.2169995104739, 808.2725547007682, 809.3080416244114, 810.2545657994659, 844.8690452979798, 845.3068483843251, 846.6401779243828, 847.4110493207223, 862.5040601654042, 848.4103548034119, 850.817074329016, 853.1937319233327, 853.3173461231021, 862.3575436299965, 613.3804857094323, 613.5858295650418, 615.2954866677629, 616.9136320915076, 618.0080970043061, 12793.61619151427, 12798.744025119538, 12811.807822882663, 12833.550825721148, 12857.035722320863, 14109.929450352682, 14154.36305366261, 14331.355089021019, 14367.425302987867, 14516.0, 11201.327920324806, 11364.204505684605, 11430.314181149157, 11539.59611413605, 11657.242279251821, 3869.8645547405704, 3896.980515097435, 3942.743721658083, 4052.7770972596495, 4067.145899361108, 51692.0, 51871.0, 53708.19437708437, 54263.91472170574, 54450.727746361015, 11221.551137954553, 11278.718032049264, 11320.320780753182, 11420.714482137846, 11517.48171332292, 19818.70271945922, 20060.996950152436, 20252.898735506227, 20287.594248114954, 20575.279865204648, 8170.182981701902, 8185.467944583583, 8230.93136085253, 8274.379421543288, 8441.788955276044, 4371.693981421334, 4459.554044595515, 4510.954890451119, 4542.159700455426, 4550.294704320836, 3478.513008178857, 3500.212452198235, 3511.894643160709, 3522.7181825453904, 3531.4879342495196, 627.9026750853534, 631.2614241337646, 647.297682015019, 647.3397134922353, 706.6925887239067, 636.4526507203801, 691.218922617439, 694.9965250173717, 704.5068452083563, 751.8872169174558, 9084.18242358191, 9399.610213984633, 9458.290628202913, 9510.191633711074, 9720.0, 588.5938702295402, 676.2594958520413, 708.1749761527865, 714.4463041143156, 716.0583832260561, 4376.868693939187, 4527.479339875957, 4599.885002874888, 4600.0, 4648.953510464919, 60419.39580604226, 61004.694976524836, 61148.082778758355, 65724.34275657278, 65889.0, 56843.715781420826, 57485.425145748006, 57667.13499297514, 58085.0, 58272.0, 51395.229071563954, 52497.737511312196, 53003.20495192575, 53047.20429193488, 54245.72877135589, 9443.527823608929, 9654.420734755937, 9717.12545870875, 9764.170045546209, 9789.118979291898, 33272.33455330928, 33854.492182616785, 34371.65628343785, 34463.13842153966, 34466.138346541535, 43611.56388436075, 46712.0, 47032.29451558161, 48247.75876120597, 48519.51480485291, 12122.575709850113, 12171.39143042862, 12360.567380141652, 12406.193597416139, 12725.872741272839, 13788.310584470937, 13970.860291396955, 13975.231362275172, 14206.502772402917, 14539.20034398076, 13064.934675326562, 13254.801177982145, 13569.864301357255, 13733.862661373258, 13872.861271387157, 13589.116707413987, 13663.316834158451, 13768.311584420939, 13809.102408343426, 13878.653033674238, 13250.668733281746, 13403.32983350848, 13454.663633409244, 13636.250006249751, 13651.38568764388, 11161.0, 11209.887901120885, 11352.659420217407, 11580.420978951188, 11737.589184378507, 11220.438978050901, 11608.825867612162, 11667.183297169116, 11791.941040294743, 11844.407779611158], "value": 6860.7331252790955, "unit": "score"}], "name": "dromaeo_css", "value": 7248.417169859829, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 113.0, 110.0, 114.0, 125.0, 112.0, 111.0, 111.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 160.0, 199.0, 130.0, 158.0, 161.0, 133.0, 192.0, 134.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 162.0, 163.0, 165.0, 171.0, 162.0, 165.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 77.0, 146.0, 74.0, 76.0, 76.0, 76.0, 100.0, 73.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 155.0, 93.0, 93.0, 92.0, 144.0, 93.0, 92.0, 157.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 100.0, 95.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 57.0, 63.0, 57.0, 56.0, 56.0, 56.0, 71.0, 54.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 79.0, 79.0, 79.0, 79.0, 78.0, 77.0, 79.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 137.0, 136.0, 134.0, 129.0, 132.0, 126.0, 177.0, 137.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 176.0, 167.0, 169.0, 174.0, 167.0, 173.0, 168.0, 174.0, 167.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 68.0, 69.0, 71.0, 72.0, 68.0, 69.0, 68.0, 77.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1564.7999999999997, "alertThreshold": 2.0}]} 21:50:10 INFO - Return code: 0 21:50:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:50:10 ERROR - # TBPL SUCCESS # 21:50:10 INFO - Running post-action listener: _resource_record_post_action 21:50:10 INFO - Running post-run listener: _resource_record_post_run 21:50:11 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 543592448; Read time: 0; Write time: 596328 21:50:11 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 190287872; Read time: 0; Write time: 337424 21:50:11 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 292200448; Read time: 0; Write time: 189468 21:50:11 INFO - Running post-run listener: _upload_blobber_files 21:50:11 INFO - Blob upload gear active. 21:50:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:50:11 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 21:50:11 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:50:11 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:50:12 INFO - (blobuploader) - INFO - Open directory for files ... 21:50:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:50:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:50:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:13 INFO - (blobuploader) - INFO - Done attempting. 21:50:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:50:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:50:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:13 INFO - (blobuploader) - INFO - Done attempting. 21:50:13 INFO - (blobuploader) - INFO - Iteration through files over. 21:50:13 INFO - Return code: 0 21:50:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:50:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:50:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3454302495c2350a66988a9256d1518705b6dd3efc12fc9110811f70550afdf52feef9db3b6d2a8440abd116b0cd4a6c1a8419a816a350ba8004e80f1a205f5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8473b0d4f3ab81d4e63b539dce713bb3df740f0c9fefdc1c57effc1b9a9e28e7eb0342c0a049bbbfad2e5bebf0aa2a2bb27029be3e9773457f362ab77baa48b5"} 21:50:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:50:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:50:13 INFO - Contents: 21:50:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3454302495c2350a66988a9256d1518705b6dd3efc12fc9110811f70550afdf52feef9db3b6d2a8440abd116b0cd4a6c1a8419a816a350ba8004e80f1a205f5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8473b0d4f3ab81d4e63b539dce713bb3df740f0c9fefdc1c57effc1b9a9e28e7eb0342c0a049bbbfad2e5bebf0aa2a2bb27029be3e9773457f362ab77baa48b5"} 21:50:13 INFO - Running post-run listener: copy_logs_to_upload_dir 21:50:13 INFO - Copying logs to upload dir... 21:50:13 INFO - mkdir: /builds/slave/test/build/upload/logs 21:50:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.632548 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-24 21:50:13.479530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:13.483309) ========= 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=00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3454302495c2350a66988a9256d1518705b6dd3efc12fc9110811f70550afdf52feef9db3b6d2a8440abd116b0cd4a6c1a8419a816a350ba8004e80f1a205f5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8473b0d4f3ab81d4e63b539dce713bb3df740f0c9fefdc1c57effc1b9a9e28e7eb0342c0a049bbbfad2e5bebf0aa2a2bb27029be3e9773457f362ab77baa48b5"} build_url:https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/fGGoLufWR3CwzHN3QnEIkw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3454302495c2350a66988a9256d1518705b6dd3efc12fc9110811f70550afdf52feef9db3b6d2a8440abd116b0cd4a6c1a8419a816a350ba8004e80f1a205f5e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8473b0d4f3ab81d4e63b539dce713bb3df740f0c9fefdc1c57effc1b9a9e28e7eb0342c0a049bbbfad2e5bebf0aa2a2bb27029be3e9773457f362ab77baa48b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:13.506845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:13.507130) ========= 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=00204705a9daa57ed339a427000001b9-1461558564.981078-1326436922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 21:50:13.592421) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 21:50:13.592695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 21:50:13.592945) ========= ========= Total master_lag: 0.17 =========