builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1461153769.86 results: success (0) buildid: 20160420023023 builduid: 61b4c6ad45e642909b320351724f3463 revision: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:49.856895) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:49.857397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:49.857679) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:49.872357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:49.872927) ========= 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=836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 05:02:49-- 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% 37.2M=0s 2016-04-20 05:02:50 (37.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173731 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.059317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.059678) ========= 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=836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.109785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.110147) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 --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 f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 --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=836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 05:02:50,151 truncating revision to first 12 chars 2016-04-20 05:02:50,151 Setting DEBUG logging. 2016-04-20 05:02:50,151 attempt 1/10 2016-04-20 05:02:50,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f71acdbd0d45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 05:02:50,559 unpacking tar archive at: fx-team-f71acdbd0d45/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.831170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.831553) ========= script_repo_revision: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.832071) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.832397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 05:02:50.843915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-20 05:02:50.844544) ========= /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=836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:02:50 INFO - MultiFileLogger online at 20160420 05:02:50 in /builds/slave/test 05:02:50 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 05:02:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:50 INFO - {'append_to_log': False, 05:02:50 INFO - 'base_work_dir': '/builds/slave/test', 05:02:50 INFO - 'blob_upload_branch': 'Fx-Team', 05:02:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:50 INFO - 'branch': 'Fx-Team', 05:02:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:50 INFO - 'config_files': ('talos/linux_config.py',), 05:02:50 INFO - 'default_actions': ('clobber', 05:02:50 INFO - 'read-buildbot-config', 05:02:50 INFO - 'download-and-extract', 05:02:50 INFO - 'populate-webroot', 05:02:50 INFO - 'create-virtualenv', 05:02:50 INFO - 'install', 05:02:50 INFO - 'run-tests'), 05:02:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:50 INFO - 'download_minidump_stackwalk': True, 05:02:50 INFO - 'download_symbols': 'ondemand', 05:02:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:50 INFO - 'installer_path': 'installer.exe', 05:02:50 INFO - 'log_level': 'info', 05:02:50 INFO - 'log_name': 'talos', 05:02:50 INFO - 'log_to_console': True, 05:02:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:02:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:02:50 INFO - 'opt_config_files': (), 05:02:50 INFO - 'pip_index': False, 05:02:50 INFO - 'sps_profile': False, 05:02:50 INFO - 'sps_profile_interval': 0, 05:02:50 INFO - 'suite': 'dromaeojs-e10s', 05:02:50 INFO - 'system_bits': '32', 05:02:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:50 INFO - 'title': 'talos-linux64-ix-028', 05:02:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:50 INFO - 'use_talos_json': True, 05:02:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:50 INFO - 'work_dir': 'build'} 05:02:50 INFO - ##### 05:02:50 INFO - ##### Running clobber step. 05:02:50 INFO - ##### 05:02:50 INFO - Running pre-action listener: _resource_record_pre_action 05:02:50 INFO - Running main action method: clobber 05:02:50 INFO - rmtree: /builds/slave/test/build 05:02:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:51 INFO - Running post-action listener: _resource_record_post_action 05:02:51 INFO - ##### 05:02:51 INFO - ##### Running read-buildbot-config step. 05:02:51 INFO - ##### 05:02:51 INFO - Running pre-action listener: _resource_record_pre_action 05:02:51 INFO - Running main action method: read_buildbot_config 05:02:51 INFO - Using buildbot properties: 05:02:51 INFO - { 05:02:51 INFO - "project": "", 05:02:51 INFO - "product": "firefox", 05:02:51 INFO - "script_repo_revision": "production", 05:02:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:02:51 INFO - "repository": "", 05:02:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:02:51 INFO - "buildid": "20160420023023", 05:02:51 INFO - "pgo_build": "True", 05:02:51 INFO - "basedir": "/builds/slave/test", 05:02:51 INFO - "buildnumber": 665, 05:02:51 INFO - "slavename": "talos-linux64-ix-028", 05:02:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:02:51 INFO - "platform": "ubuntu64_hw", 05:02:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:02:51 INFO - "branch": "fx-team", 05:02:51 INFO - "repo_path": "integration/fx-team", 05:02:51 INFO - "revision": "f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43", 05:02:51 INFO - "stage_platform": "linux64-pgo", 05:02:51 INFO - "builduid": "61b4c6ad45e642909b320351724f3463", 05:02:51 INFO - "slavebuilddir": "test" 05:02:51 INFO - } 05:02:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:02:51 INFO - Running post-action listener: _resource_record_post_action 05:02:51 INFO - ##### 05:02:51 INFO - ##### Running download-and-extract step. 05:02:51 INFO - ##### 05:02:51 INFO - Running pre-action listener: _resource_record_pre_action 05:02:51 INFO - Running main action method: download_and_extract 05:02:51 INFO - mkdir: /builds/slave/test/build/tests 05:02: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')]} 05:02:51 INFO - https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:02:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:02:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:02:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:02:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:02:52 INFO - Downloaded 1361 bytes. 05:02:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:02:52 INFO - Using the following test package requirements: 05:02:52 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:02:52 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:02:52 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:02:52 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'jsshell-linux-x86_64.zip'], 05:02:52 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:02:52 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:02:52 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:02:52 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:02:52 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:02:52 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:02:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:02:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:02:52 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')]} 05:02:52 INFO - https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:03:00 INFO - Downloaded 23838309 bytes. 05:03:00 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'] 05:03:00 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 05:03:01 INFO - Return code: 0 05:03:01 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 05:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:01 INFO - https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:03:06 INFO - Downloaded 23838309 bytes. 05:03:06 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'] 05:03:06 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 05:03:07 INFO - Return code: 0 05:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:07 INFO - https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:03:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:03:09 INFO - Downloaded 10845952 bytes. 05:03:09 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'] 05:03:09 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 05:03:09 INFO - Return code: 0 05:03:09 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')]} 05:03:09 INFO - https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:03:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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 05:03:11 INFO - Downloaded 58313808 bytes. 05:03:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:11 INFO - mkdir: /builds/slave/test/properties 05:03:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:03:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:03:11 INFO - Contents: 05:03:11 INFO - build_url:https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:03:12 INFO - Running post-action listener: _resource_record_post_action 05:03:12 INFO - Running post-action listener: set_extra_try_arguments 05:03:12 INFO - ##### 05:03:12 INFO - ##### Running populate-webroot step. 05:03:12 INFO - ##### 05:03:12 INFO - Running pre-action listener: _resource_record_pre_action 05:03:12 INFO - Running main action method: populate_webroot 05:03:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:12 INFO - '--tppagecycles', 05:03:12 INFO - '7'], 05:03:12 INFO - 'tests': ['tsvgm']}}, 05:03:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:03:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:03:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:03:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['damp', 'tps']}, 05:03:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'tests': ['damp', 'tps']}, 05:03:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['dromaeo_dom']}, 05:03:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['a11yr', 05:03:12 INFO - 'ts_paint', 05:03:12 INFO - 'tpaint', 05:03:12 INFO - 'sessionrestore', 05:03:12 INFO - 'sessionrestore_no_auto_restore', 05:03:12 INFO - 'tabpaint']}, 05:03:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:03:12 INFO - 'ts_paint', 05:03:12 INFO - 'tpaint', 05:03:12 INFO - 'sessionrestore', 05:03:12 INFO - 'sessionrestore_no_auto_restore', 05:03:12 INFO - 'tabpaint']}, 05:03:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:03:12 INFO - 'ts_paint', 05:03:12 INFO - 'tpaint', 05:03:12 INFO - 'sessionrestore', 05:03:12 INFO - 'sessionrestore_no_auto_restore', 05:03:12 INFO - 'tabpaint']}, 05:03:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:03:12 INFO - 'ts_paint', 05:03:12 INFO - 'tpaint', 05:03:12 INFO - 'sessionrestore', 05:03:12 INFO - 'sessionrestore_no_auto_restore', 05:03:12 INFO - 'tabpaint']}, 05:03:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['a11yr', 05:03:12 INFO - 'ts_paint', 05:03:12 INFO - 'tpaint', 05:03:12 INFO - 'sessionrestore', 05:03:12 INFO - 'sessionrestore_no_auto_restore', 05:03:12 INFO - 'tabpaint']}, 05:03:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['a11yr', 05:03:12 INFO - 'ts_paint', 05:03:12 INFO - 'tpaint', 05:03:12 INFO - 'sessionrestore', 05:03:12 INFO - 'sessionrestore_no_auto_restore', 05:03:12 INFO - 'tabpaint']}, 05:03:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['tsvgx', 05:03:12 INFO - 'tsvgr_opacity', 05:03:12 INFO - 'tart', 05:03:12 INFO - 'tscrollx', 05:03:12 INFO - 'cart']}, 05:03:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:03:12 INFO - 'tsvgr_opacity', 05:03:12 INFO - 'tart', 05:03:12 INFO - 'tscrollx', 05:03:12 INFO - 'cart']}, 05:03:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'talos_options': ['--disable-e10s'], 05:03:12 INFO - 'tests': ['tp5o']}, 05:03:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'tests': ['tp5o']}, 05:03:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'talos_options': ['--disable-e10s', 05:03:12 INFO - '--xperf_path', 05:03:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:12 INFO - 'tests': ['tp5n']}, 05:03:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:12 INFO - 'talos_options': ['--xperf_path', 05:03:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:12 INFO - 'tests': ['tp5n']}}, 05:03:12 INFO - 'talos.zip': {'path': '', 05:03:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:12 INFO - Running post-action listener: _resource_record_post_action 05:03:12 INFO - ##### 05:03:12 INFO - ##### Running create-virtualenv step. 05:03:12 INFO - ##### 05:03:12 INFO - Running pre-action listener: _resource_record_pre_action 05:03:12 INFO - Running main action method: create_virtualenv 05:03:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:03:12 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 05:03:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:03:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:12 INFO - Using real prefix '/usr' 05:03:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:03:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:14 INFO - Installing pip.................done. 05:03:14 INFO - Return code: 0 05:03:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:03:14 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')]} 05:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:14 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')]} 05:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:14 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:14 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 05:03:14 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 05:03:14 INFO - Using env: {'DISPLAY': ':0', 05:03:14 INFO - 'HOME': '/home/cltbld', 05:03:14 INFO - 'LANG': 'en_US.UTF-8', 05:03:14 INFO - 'LANGUAGE': 'en_US:en', 05:03:14 INFO - 'LOGNAME': 'cltbld', 05:03:14 INFO - 'MAIL': '/var/mail/cltbld', 05:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:14 INFO - 'MOZ_NO_REMOTE': '1', 05:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:14 INFO - 'NO_EM_RESTART': '1', 05:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:14 INFO - 'PWD': '/builds/slave/test', 05:03:14 INFO - 'SHELL': '/bin/bash', 05:03:14 INFO - 'SHLVL': '1', 05:03:14 INFO - 'TERM': 'linux', 05:03:14 INFO - 'TMOUT': '86400', 05:03:14 INFO - 'USER': 'cltbld', 05:03:14 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:14 INFO - '_': '/tools/buildbot/bin/python'} 05:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:15 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 05:03:15 INFO - Cleaning up... 05:03:15 INFO - Return code: 0 05:03:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:03: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')]} 05:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:03:15 INFO - Using env: {'DISPLAY': ':0', 05:03:15 INFO - 'HOME': '/home/cltbld', 05:03:15 INFO - 'LANG': 'en_US.UTF-8', 05:03:15 INFO - 'LANGUAGE': 'en_US:en', 05:03:15 INFO - 'LOGNAME': 'cltbld', 05:03:15 INFO - 'MAIL': '/var/mail/cltbld', 05:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:15 INFO - 'MOZ_NO_REMOTE': '1', 05:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:15 INFO - 'NO_EM_RESTART': '1', 05:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:15 INFO - 'PWD': '/builds/slave/test', 05:03:15 INFO - 'SHELL': '/bin/bash', 05:03:15 INFO - 'SHLVL': '1', 05:03:15 INFO - 'TERM': 'linux', 05:03:15 INFO - 'TMOUT': '86400', 05:03:15 INFO - 'USER': 'cltbld', 05:03:15 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:15 INFO - '_': '/tools/buildbot/bin/python'} 05:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:15 INFO - Downloading/unpacking psutil>=0.7.1 05:03:15 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 05:03:15 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 05:03:15 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 05:03:15 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 05:03:15 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 05:03:15 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 05:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:17 INFO - Installing collected packages: psutil 05:03:17 INFO - Running setup.py install for psutil 05:03:17 INFO - building 'psutil._psutil_linux' extension 05:03:17 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 05:03:17 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 05:03:17 INFO - building 'psutil._psutil_posix' extension 05:03:17 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 05:03:17 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 05:03:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:17 INFO - Successfully installed psutil 05:03:17 INFO - Cleaning up... 05:03:17 INFO - Return code: 0 05:03:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:03:17 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')]} 05:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:17 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')]} 05:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:17 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:17 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 05:03:17 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 05:03:17 INFO - Using env: {'DISPLAY': ':0', 05:03:17 INFO - 'HOME': '/home/cltbld', 05:03:17 INFO - 'LANG': 'en_US.UTF-8', 05:03:17 INFO - 'LANGUAGE': 'en_US:en', 05:03:17 INFO - 'LOGNAME': 'cltbld', 05:03:17 INFO - 'MAIL': '/var/mail/cltbld', 05:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:17 INFO - 'MOZ_NO_REMOTE': '1', 05:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:17 INFO - 'NO_EM_RESTART': '1', 05:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:17 INFO - 'PWD': '/builds/slave/test', 05:03:17 INFO - 'SHELL': '/bin/bash', 05:03:17 INFO - 'SHLVL': '1', 05:03:17 INFO - 'TERM': 'linux', 05:03:17 INFO - 'TMOUT': '86400', 05:03:17 INFO - 'USER': 'cltbld', 05:03:17 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:17 INFO - '_': '/tools/buildbot/bin/python'} 05:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:03:20 INFO - Installing collected packages: mozsystemmonitor 05:03:20 INFO - Running setup.py install for mozsystemmonitor 05:03:20 INFO - Successfully installed mozsystemmonitor 05:03:20 INFO - Cleaning up... 05:03:20 INFO - Return code: 0 05:03:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:03:20 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')]} 05:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:20 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')]} 05:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:20 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:20 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 05:03:20 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 05:03:20 INFO - Using env: {'DISPLAY': ':0', 05:03:20 INFO - 'HOME': '/home/cltbld', 05:03:20 INFO - 'LANG': 'en_US.UTF-8', 05:03:20 INFO - 'LANGUAGE': 'en_US:en', 05:03:20 INFO - 'LOGNAME': 'cltbld', 05:03:20 INFO - 'MAIL': '/var/mail/cltbld', 05:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:20 INFO - 'MOZ_NO_REMOTE': '1', 05:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:20 INFO - 'NO_EM_RESTART': '1', 05:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:20 INFO - 'PWD': '/builds/slave/test', 05:03:20 INFO - 'SHELL': '/bin/bash', 05:03:20 INFO - 'SHLVL': '1', 05:03:20 INFO - 'TERM': 'linux', 05:03:20 INFO - 'TMOUT': '86400', 05:03:20 INFO - 'USER': 'cltbld', 05:03:20 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:20 INFO - '_': '/tools/buildbot/bin/python'} 05:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:03:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 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 05:03:22 INFO - Downloading docopt-0.6.1.tar.gz 05:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:23 INFO - Running setup.py install for blobuploader 05:03:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:03:23 INFO - Running setup.py install for requests 05:03:23 INFO - Running setup.py install for docopt 05:03:23 INFO - Successfully installed blobuploader requests docopt 05:03:23 INFO - Cleaning up... 05:03:23 INFO - Return code: 0 05:03:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:23 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:23 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 05:03:23 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 05:03:23 INFO - Using env: {'DISPLAY': ':0', 05:03:23 INFO - 'HOME': '/home/cltbld', 05:03:23 INFO - 'LANG': 'en_US.UTF-8', 05:03:23 INFO - 'LANGUAGE': 'en_US:en', 05:03:23 INFO - 'LOGNAME': 'cltbld', 05:03:23 INFO - 'MAIL': '/var/mail/cltbld', 05:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:23 INFO - 'MOZ_NO_REMOTE': '1', 05:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:23 INFO - 'NO_EM_RESTART': '1', 05:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:23 INFO - 'PWD': '/builds/slave/test', 05:03:23 INFO - 'SHELL': '/bin/bash', 05:03:23 INFO - 'SHLVL': '1', 05:03:23 INFO - 'TERM': 'linux', 05:03:23 INFO - 'TMOUT': '86400', 05:03:23 INFO - 'USER': 'cltbld', 05:03:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:23 INFO - '_': '/tools/buildbot/bin/python'} 05:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:23 INFO - Running setup.py (path:/tmp/pip-xD2GHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:23 INFO - Running setup.py (path:/tmp/pip-TmpwPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:24 INFO - Running setup.py (path:/tmp/pip-xJv84m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:24 INFO - Running setup.py (path:/tmp/pip-H75fJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:24 INFO - Running setup.py (path:/tmp/pip-7dwRce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:24 INFO - Running setup.py (path:/tmp/pip-D0KsjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:24 INFO - Running setup.py (path:/tmp/pip-xaL56l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:24 INFO - Running setup.py (path:/tmp/pip-u8qjOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:24 INFO - Running setup.py (path:/tmp/pip-KSgnEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:24 INFO - Running setup.py (path:/tmp/pip-ziLH1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:24 INFO - Running setup.py (path:/tmp/pip-2okudO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:24 INFO - Running setup.py (path:/tmp/pip-b40gRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:24 INFO - Running setup.py (path:/tmp/pip-mwX3Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:24 INFO - Running setup.py (path:/tmp/pip-eqfLU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:24 INFO - Running setup.py (path:/tmp/pip-4LX3ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:24 INFO - Running setup.py (path:/tmp/pip-_Fx0K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:25 INFO - Running setup.py (path:/tmp/pip-rlXo1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:25 INFO - Running setup.py install for manifestparser 05:03:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Running setup.py install for mozcrash 05:03:25 INFO - Running setup.py install for mozdebug 05:03:25 INFO - Running setup.py install for mozdevice 05:03:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Running setup.py install for mozfile 05:03:25 INFO - Running setup.py install for mozhttpd 05:03:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Running setup.py install for mozinfo 05:03:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Running setup.py install for mozInstall 05:03:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:03:25 INFO - Running setup.py install for mozleak 05:03:26 INFO - Running setup.py install for mozlog 05:03:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:03:26 INFO - Running setup.py install for moznetwork 05:03:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:03:26 INFO - Running setup.py install for mozprocess 05:03:26 INFO - Running setup.py install for mozprofile 05:03:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:03:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:03:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:03:26 INFO - Running setup.py install for mozrunner 05:03:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:03:26 INFO - Running setup.py install for mozscreenshot 05:03:26 INFO - Running setup.py install for moztest 05:03:26 INFO - Running setup.py install for mozversion 05:03:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:03:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:26 INFO - Cleaning up... 05:03:26 INFO - Return code: 0 05:03:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:26 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')]} 05:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:26 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')]} 05:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:26 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:26 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 05:03:26 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 05:03:26 INFO - Using env: {'DISPLAY': ':0', 05:03:26 INFO - 'HOME': '/home/cltbld', 05:03:26 INFO - 'LANG': 'en_US.UTF-8', 05:03:26 INFO - 'LANGUAGE': 'en_US:en', 05:03:26 INFO - 'LOGNAME': 'cltbld', 05:03:26 INFO - 'MAIL': '/var/mail/cltbld', 05:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:26 INFO - 'MOZ_NO_REMOTE': '1', 05:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:26 INFO - 'NO_EM_RESTART': '1', 05:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:26 INFO - 'PWD': '/builds/slave/test', 05:03:26 INFO - 'SHELL': '/bin/bash', 05:03:26 INFO - 'SHLVL': '1', 05:03:26 INFO - 'TERM': 'linux', 05:03:26 INFO - 'TMOUT': '86400', 05:03:26 INFO - 'USER': 'cltbld', 05:03:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:26 INFO - '_': '/tools/buildbot/bin/python'} 05:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:03:27 INFO - Running setup.py (path:/tmp/pip-CMz7VV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:03:27 INFO - Running setup.py (path:/tmp/pip-dkJpzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:03:27 INFO - Running setup.py (path:/tmp/pip-2H1ix_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:03:27 INFO - Running setup.py (path:/tmp/pip-rOnpFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:03:27 INFO - Running setup.py (path:/tmp/pip-kniP0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:03:27 INFO - Running setup.py (path:/tmp/pip-GxTv11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:03:27 INFO - Running setup.py (path:/tmp/pip-KmhKBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:03:27 INFO - Running setup.py (path:/tmp/pip-2EhbXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:03:27 INFO - Running setup.py (path:/tmp/pip-HNFxP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:03:27 INFO - Running setup.py (path:/tmp/pip-zsmGhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:03:27 INFO - Running setup.py (path:/tmp/pip-DMocBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:03:27 INFO - Running setup.py (path:/tmp/pip-mGX2qF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:03:27 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)) 05:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:03:28 INFO - Running setup.py (path:/tmp/pip-UOUHho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:03:28 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)) 05:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:03:28 INFO - Running setup.py (path:/tmp/pip-m219nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:03:28 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)) 05:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:28 INFO - Running setup.py (path:/tmp/pip-g0UmPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:03:28 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)) 05:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:03:28 INFO - Running setup.py (path:/tmp/pip-o5ZdPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:03:28 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)) 05:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:03:28 INFO - Running setup.py (path:/tmp/pip-gFYg2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:03:28 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)) 05:03:28 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)) 05:03:28 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)) 05:03:28 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)) 05:03:28 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)) 05:03:28 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)) 05:03:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:28 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 05:03:28 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 05:03:28 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 05:03:28 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 05:03:28 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 05:03:28 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 05:03:30 INFO - Downloading blessings-1.6.tar.gz 05:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:30 INFO - Installing collected packages: blessings 05:03:30 INFO - Running setup.py install for blessings 05:03:30 INFO - Successfully installed blessings 05:03:30 INFO - Cleaning up... 05:03:30 INFO - Return code: 0 05:03:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:03:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:30 INFO - Reading from file tmpfile_stdout 05:03:30 INFO - Current package versions: 05:03:30 INFO - argparse == 1.2.1 05:03:30 INFO - blessings == 1.6 05:03:30 INFO - blobuploader == 1.2.4 05:03:30 INFO - docopt == 0.6.1 05:03:30 INFO - manifestparser == 1.1 05:03:30 INFO - mozInstall == 1.12 05:03:30 INFO - mozcrash == 0.17 05:03:30 INFO - mozdebug == 0.1 05:03:30 INFO - mozdevice == 0.48 05:03:30 INFO - mozfile == 1.2 05:03:30 INFO - mozhttpd == 0.7 05:03:30 INFO - mozinfo == 0.9 05:03:30 INFO - mozleak == 0.1 05:03:30 INFO - mozlog == 3.1 05:03:30 INFO - moznetwork == 0.27 05:03:30 INFO - mozprocess == 0.22 05:03:30 INFO - mozprofile == 0.28 05:03:30 INFO - mozrunner == 6.11 05:03:30 INFO - mozscreenshot == 0.1 05:03:30 INFO - mozsystemmonitor == 0.0 05:03:30 INFO - moztest == 0.7 05:03:30 INFO - mozversion == 1.4 05:03:30 INFO - psutil == 3.1.1 05:03:30 INFO - requests == 1.2.3 05:03:30 INFO - wsgiref == 0.1.2 05:03:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:03:30 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')]} 05:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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')]} 05:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:30 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 05:03:30 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 05:03:30 INFO - Using env: {'DISPLAY': ':0', 05:03:30 INFO - 'HOME': '/home/cltbld', 05:03:30 INFO - 'LANG': 'en_US.UTF-8', 05:03:30 INFO - 'LANGUAGE': 'en_US:en', 05:03:30 INFO - 'LOGNAME': 'cltbld', 05:03:30 INFO - 'MAIL': '/var/mail/cltbld', 05:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:30 INFO - 'MOZ_NO_REMOTE': '1', 05:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:30 INFO - 'NO_EM_RESTART': '1', 05:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:30 INFO - 'PWD': '/builds/slave/test', 05:03:30 INFO - 'SHELL': '/bin/bash', 05:03:30 INFO - 'SHLVL': '1', 05:03:30 INFO - 'TERM': 'linux', 05:03:30 INFO - 'TMOUT': '86400', 05:03:30 INFO - 'USER': 'cltbld', 05:03:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:30 INFO - '_': '/tools/buildbot/bin/python'} 05:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 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)) 05:03:30 INFO - Cleaning up... 05:03:30 INFO - Return code: 0 05:03:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:03:30 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')]} 05:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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')]} 05:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:30 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:30 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 05:03:30 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 05:03:30 INFO - Using env: {'DISPLAY': ':0', 05:03:30 INFO - 'HOME': '/home/cltbld', 05:03:30 INFO - 'LANG': 'en_US.UTF-8', 05:03:30 INFO - 'LANGUAGE': 'en_US:en', 05:03:30 INFO - 'LOGNAME': 'cltbld', 05:03:30 INFO - 'MAIL': '/var/mail/cltbld', 05:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:30 INFO - 'MOZ_NO_REMOTE': '1', 05:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:30 INFO - 'NO_EM_RESTART': '1', 05:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:30 INFO - 'PWD': '/builds/slave/test', 05:03:30 INFO - 'SHELL': '/bin/bash', 05:03:30 INFO - 'SHLVL': '1', 05:03:30 INFO - 'TERM': 'linux', 05:03:30 INFO - 'TMOUT': '86400', 05:03:30 INFO - 'USER': 'cltbld', 05:03:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:30 INFO - '_': '/tools/buildbot/bin/python'} 05:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:31 INFO - Downloading/unpacking jsonschema 05:03:31 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 05:03:31 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 05:03:31 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 05:03:31 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 05:03:31 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 05:03:31 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 05:03:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:32 INFO - Downloading/unpacking functools32 (from jsonschema) 05:03:32 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 05:03:32 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 05:03:32 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 05:03:32 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 05:03:32 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 05:03:32 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 05:03:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:33 INFO - warning: no files found matching '*.txt' 05:03:33 INFO - no previously-included directories found matching 'build' 05:03:33 INFO - no previously-included directories found matching 'dist' 05:03:33 INFO - no previously-included directories found matching '.git*' 05:03:33 INFO - Installing collected packages: jsonschema, functools32 05:03:33 INFO - Running setup.py install for functools32 05:03:33 INFO - warning: no files found matching '*.txt' 05:03:33 INFO - no previously-included directories found matching 'build' 05:03:33 INFO - no previously-included directories found matching 'dist' 05:03:33 INFO - no previously-included directories found matching '.git*' 05:03:33 INFO - Successfully installed jsonschema functools32 05:03:33 INFO - Cleaning up... 05:03:33 INFO - Return code: 0 05:03:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:03:33 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')]} 05:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:33 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')]} 05:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:33 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 0x7f898cc14f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16915a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, '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': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', '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 05:03:33 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 05:03:33 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 05:03:33 INFO - Using env: {'DISPLAY': ':0', 05:03:33 INFO - 'HOME': '/home/cltbld', 05:03:33 INFO - 'LANG': 'en_US.UTF-8', 05:03:33 INFO - 'LANGUAGE': 'en_US:en', 05:03:33 INFO - 'LOGNAME': 'cltbld', 05:03:33 INFO - 'MAIL': '/var/mail/cltbld', 05:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:33 INFO - 'MOZ_NO_REMOTE': '1', 05:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:33 INFO - 'NO_EM_RESTART': '1', 05:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:33 INFO - 'PWD': '/builds/slave/test', 05:03:33 INFO - 'SHELL': '/bin/bash', 05:03:33 INFO - 'SHLVL': '1', 05:03:33 INFO - 'TERM': 'linux', 05:03:33 INFO - 'TMOUT': '86400', 05:03:33 INFO - 'USER': 'cltbld', 05:03:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:33 INFO - '_': '/tools/buildbot/bin/python'} 05:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:33 INFO - Downloading/unpacking flake8 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:33 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 05:03:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:03:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:03:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:03:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:03:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:03:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:03:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:03:36 INFO - no previously-included directories found matching 'docs/_build' 05:03:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:03:36 INFO - Running setup.py install for pep8 05:03:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:03:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:03:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:03:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:03:36 INFO - no previously-included directories found matching 'docs/_build' 05:03:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:03:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:03:36 INFO - Cleaning up... 05:03:36 INFO - Return code: 0 05:03:36 INFO - Running post-action listener: _resource_record_post_action 05:03:36 INFO - Running post-action listener: _start_resource_monitoring 05:03:36 INFO - Starting resource monitoring. 05:03:36 INFO - ##### 05:03:36 INFO - ##### Running install step. 05:03:36 INFO - ##### 05:03:36 INFO - Running pre-action listener: _resource_record_pre_action 05:03:36 INFO - Running main action method: install 05:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:03:36 INFO - Reading from file tmpfile_stdout 05:03:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:03:36 INFO - Reading from file tmpfile_stdout 05:03:36 INFO - Output received: 05:03:36 INFO - Usage: mozinstall [options] installer 05:03:36 INFO - Options: 05:03:36 INFO - -h, --help show this help message and exit 05:03:36 INFO - -d DEST, --destination=DEST 05:03:36 INFO - Directory to install application into. [default: 05:03:36 INFO - "/builds/slave/test"] 05:03:36 INFO - --app=APP Application being installed. [default: firefox] 05:03:36 INFO - mkdir: /builds/slave/test/build/application 05:03:36 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'] 05:03:36 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 05:03:53 INFO - Reading from file tmpfile_stdout 05:03:53 INFO - Output received: 05:03:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:03:53 INFO - Running post-action listener: _resource_record_post_action 05:03:53 INFO - ##### 05:03:53 INFO - ##### Running run-tests step. 05:03:53 INFO - ##### 05:03:53 INFO - Running pre-action listener: _resource_record_pre_action 05:03:53 INFO - Running main action method: run_tests 05:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:03:53 INFO - Python 2.7.3 05:03:53 INFO - Return code: 0 05:03:53 INFO - grabbing minidump binary from tooltool 05:03: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')]} 05:03:53 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 0x1720410>, '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 0x1721310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17217a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:03:53 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 05:03:53 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 05:03:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:03:53 INFO - Return code: 0 05:03:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:03:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:03:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:03:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:03:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:03:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:03:54 INFO - Return code: 0 05:03:54 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/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:03:54 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/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 05:03:54 INFO - Using env: {'DISPLAY': ':0', 05:03:54 INFO - 'HOME': '/home/cltbld', 05:03:54 INFO - 'LANG': 'en_US.UTF-8', 05:03:54 INFO - 'LANGUAGE': 'en_US:en', 05:03:54 INFO - 'LOGNAME': 'cltbld', 05:03:54 INFO - 'MAIL': '/var/mail/cltbld', 05:03:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:03:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:54 INFO - 'MOZ_NO_REMOTE': '1', 05:03:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:54 INFO - 'NO_EM_RESTART': '1', 05:03:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:03:54 INFO - 'PWD': '/builds/slave/test', 05:03:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:03:54 INFO - 'SHELL': '/bin/bash', 05:03:54 INFO - 'SHLVL': '1', 05:03:54 INFO - 'TERM': 'linux', 05:03:54 INFO - 'TMOUT': '86400', 05:03:54 INFO - 'USER': 'cltbld', 05:03:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965', 05:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:54 INFO - '_': '/tools/buildbot/bin/python'} 05:03:54 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/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:03:54 INFO - mozversion application_buildid: 20160420023023 05:03:54 INFO - mozversion application_changeset: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 05:03:54 INFO - mozversion application_display_name: Nightly 05:03:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:03:54 INFO - mozversion application_name: Firefox 05:03:54 INFO - mozversion application_remotingname: firefox 05:03:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:03:54 INFO - mozversion application_vendor: Mozilla 05:03:54 INFO - mozversion application_version: 48.0a1 05:03:54 INFO - mozversion platform_buildid: 20160420023023 05:03:54 INFO - mozversion platform_changeset: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 05:03:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:03:54 INFO - mozversion platform_version: 48.0a1 05:03:54 INFO - using testdate: 1461153834 05:03:54 INFO - actual date: 1461153834 05:03:54 INFO - starting webserver on 'localhost:41959' 05:03:54 INFO - SUITE-START | Running 2 tests 05:03:54 INFO - TEST-START | dromaeo_css 05:03:54 INFO - operating with platform_type : linux_ 05:03:54 INFO - Initialising browser for dromaeo_css test... 05:03:54 INFO - TEST-INFO | started process 18965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl0aTfd/profile http://localhost:41959/getInfo.html) 05:03:58 INFO - PROCESS | 18965 | 05:03:58 INFO - PROCESS | 18965 | (process:19031): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:03:59 INFO - PROCESS | 18965 | __metrics Screen width/height:1600/1200 05:03:59 INFO - PROCESS | 18965 | colorDepth:24 05:03:59 INFO - PROCESS | 18965 | Browser inner width/height: 1024/697 05:03:59 INFO - PROCESS | 18965 | __metrics 05:04:00 ERROR - PROCESS | 18965 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:04:01 INFO - TEST-INFO | 18965: exit 0 05:04:01 INFO - Browser initialized. 05:04:01 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:01 INFO - TEST-INFO | started process 19082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl0aTfd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:03 INFO - PROCESS | 19082 | 05:04:03 INFO - PROCESS | 19082 | (process:19143): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:04:13 INFO - PROCESS | 19082 | RSS: Main: 163446784 05:04:13 INFO - PROCESS | 19082 | 05:05:02 INFO - PROCESS | 19082 | 1461153902656 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] 05:07:10 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:41959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41959/tests/dromaeo/cssquery-ext.html) 05:07:11 INFO - PROCESS | 19082 | RSS: Main: 168460288 05:07:11 INFO - PROCESS | 19082 | 05:10:13 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:41959/tests/dromaeo/cssquery-ext.html (next: http://localhost:41959/tests/dromaeo/cssquery-jquery.html) 05:10:14 INFO - PROCESS | 19082 | RSS: Main: 165359616 05:10:14 INFO - PROCESS | 19082 | 05:13:15 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:41959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41959/tests/dromaeo/cssquery-mootools.html) 05:13:16 INFO - PROCESS | 19082 | RSS: Main: 166637568 05:13:16 INFO - PROCESS | 19082 | 05:16:18 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:41959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41959/tests/dromaeo/cssquery-prototype.html) 05:16:18 INFO - PROCESS | 19082 | RSS: Main: 164196352 05:16:18 INFO - PROCESS | 19082 | 05:19:21 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:41959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41959/tests/dromaeo/cssquery-yui.html) 05:19:21 INFO - PROCESS | 19082 | RSS: Main: 165380096 05:19:21 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | Cycle 1(1): loaded http://localhost:41959/tests/dromaeo/cssquery-yui.html (next: http://localhost:41959/tests/dromaeo/cssquery-dojo.html) 05:22:24 INFO - PROCESS | 19082 | RSS: Main: 167124992 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | __start_tp_report 05:22:24 INFO - PROCESS | 19082 | _x_x_mozilla_page_load 05:22:24 INFO - PROCESS | 19082 | _x_x_mozilla_page_load_details 05:22:24 INFO - PROCESS | 19082 | |i|pagename|runs| 05:22:24 INFO - PROCESS | 19082 | |0;dojo.html;3131.138936792382;3177.841107944601;3182.7135557799793;3210.2455922858107;3220.0822765511834;5377.220303056055;5395.190721391788;5407.83776486705;5443.673379597227;5460.453954604538;5255.605829562779;5327.973360133204;5356.812511562086;5368.275282836816;5392.056390131721;4875.317455556216;4905.117078925792;4906.632002599819;4954.876128096808;4962.702237865721;4829.51704829516;5037.697738135724;5051.191809310511;5062.544371006608;5067.062593420229;4860.8298709545;4943.011397720452;4943.184374578191;4965.981973695384;4985.202367621199;4847.151748444044;4888.2178851383605;4894.755262236909;4895.0944075345815;4919.237518184687;4860.586850117745;4866.051120031595;4885.926711099336;4891.4863939286215;4936.703797772145;5184.662996905189;5240.554552863011;5307.203919412081;5312.442193569696;5314.0169068722025;5603.159526071081;5611.102223644238;5616.634918730269;5632.324121105453;5651;5611.663300202001;5663.8584035399035;5680.829575112753;5684.062129748587;5712.542996560265;5268;5297.258383826229;5297.999999999962;5330.946690533123;5350.0904846176245;5899.321578018497;5902.3507414184405;5945.910811337833;5948.315943666534;5959.910601340984;5496.065668836308;5626.746796394172;5645.830625081254;5716.885662286731;5738.598298119092;5778.3643799182055;5779.335376431764;5783.508401785895;5785.190073389729;5832.941670583325;5651.463111004448;5670.886582268332;5747.8563035924435;5752.884942301131;5753.942460575425;5571.1086226203615;5695.772169113272;5752.712364381848;5753.108268218432;5792.9710351447975;4310.482742070972;4343.1747967886;4345.326474396474;4363.4763828340165;4381.452318460192;3922.2939870822956;3933.2330195612153;3935.4490371348033;3948.7038472114705;3965.325894597868;5473;5530.640508366943;5530.917036244459;5533.142362933751;5538.695371754511;5686.402927692533;5710.086386178192;5712.428757124254;5714.457126572969;5729.48434640876;5429.701366424884;5430.104032834538;5445.101558242845;5445.401005889349;5459.808906688327;4820.975895120502;4946.975265123651;4974.751262436864;5020.824271150492;5047.116754568009;5994.220751302303;6002.279726432856;6014.879702405928;6028.2766068072115;6036.577439579275;5806.79676211339;5817.418258174149;5819.301683797971;5846.210761547137;5849.561282903885;5926.2295901532525;5942.405759424023;5983.102534619842;6003.609765365237;6033.366496517978;5692.601517893708;5707.686077265625;5710.8001219957105;5719.8570035749435;5741.684207368635;5615.438456154352;5792.160136780228;5826.359100498857;5832.096025116114;5839.883202336015;5532.28080349552;5585.9720701397855;5599.776008959596;5615.241942337732;5645.491905728504;5554.416786237387;5620.381758006534;5669.659820410789;5675.148727690879;5688.459596338341;5501.14732216507;5571.526420254324;5585.972070139624;5593.468620481048;5595.636283641713;5571.66570005801;5637.52081073097;5720.799772007959;5737.483626473638;5763.049096898964;5430.728463576885;5433.130699088285;5442.12925931849;5463.562914966873;5476 05:22:24 INFO - PROCESS | 19082 | |1;ext.html;611.6024584020386;645.0260107238071;656.5765081522417;685.8696847598959;724.4638967164296;35866.462003069944;37337.25325493488;37365.813170934176;37474.4378834317;37491.4376284356;39941.60058399415;40569.797151014274;40649.59350406495;40703;40821;8515.574221288942;8676.392652514327;8717.651293948265;8728.345374096969;8735.606897689619;8551.700690475835;8619.138086191393;8634.827303453927;8644.135586441369;8679.652813887436;8589.26991205745;8666.39335246533;8691.130886911322;8716.477011379306;8732.563371831415;8648.394612377137;8675.479471231714;8702.521361325125;8706.085860984569;8731.825363492759;8378.622961966727;8626.654933802703;8645.567721613894;8653.437526560754;8697.47815131088;33205.6679433205;38377.61622383796;38684;38845.41731874024;39029.80485097556;3282.5404443377947;3318.3529211803707;3330.96669033309;3342.181165614416;3376.324735052999;27035.45929081427;27131.593026104623;27662.44675106507;27793.16620501368;27901.302467438272;4071.2061148076136;4130.173965206971;4133.7106402551835;4157.958420415787;4339.913201735948;193720;194213;194228;195008;228508;34441.31117377638;34548.654513454545;34627.4805877912;35285.823570881985;36239.4564081539;34637;34658.82670586631;34680.30639387198;34833.30333393318;34885.476717849255;13249.801252981213;13384.598462046155;13393.464261429628;13438.798418023738;13505.189688618519;10964.56141754321;11027.56641636582;11030.944845275722;11036.503357348938;11053.392063436428;8297.751067467985;8324.542150181798;8335.874961875577;8390.286825619769;8399.076101628816;3222.371637530659;3233.854476548561;3256.9022929311686;3264.755143364257;3283.097148284241;1058.1588036815886;1111.8054340490544;1172.7888979983513;1178.9250918383534;1233.5620854596668;31290;31397.37205255882;31412.37175256528;31552.842235788674;32478;1183.5798291606527;1186.5965571705663;1188.5127097889824;1261.1863467173473;1322.2793577500286;16789.6642067158;16858;17013.979161250365;17062.573435664206;17228;456974;461471;463342;463911;464797;57237.71381143068;57836.71081644565;57994.42005579975;58001;58189.70905145447;1391.1583491987403;1402.9438822447191;1413.9787903181461;1426.5363756778881;1429.742646323651;29654.406911862072;30860.84569577138;32812.1796955078;34531.30937381289;34600.65399346075;55439;56683.43316566782;56976.71511642415;56994.7150264246;57172;414499;419850;420828;421205;422719;42066.789666051474;42682.78658606687;43271;43671;43716.814159292546;48248;48343.5165648339;48630;50045;50345.74827125841;39201;39701.602983970944;40039.39940900947;40233.79883100566;41245.38131928084;38919.805400972815;40023.36460262646;40292.59707402888;40618.59381406148;41148.588514114475;36591.45112823363;41119.58880411277;42283.577164229195;43491.782541087094;43543.12913741771;30734.69265307408;33507.83246083754;33849.661503385636;33918.66081339254;33968.66031339655;27154;27467.86266068657;27895;28006.579901301906;28240.85879570589 05:22:24 INFO - PROCESS | 19082 | |2;jquery.html;384.85375557288233;388.2913682529383;394.4302866822649;395.71508513870003;401.7609522334211;14538.34577444015;17172;17889.55276118096;18462.353817616386;18605.441836744885;11062.22564420491;11720.413979301044;11748;18410.171542280597;18555.907220463912;4787.138315103271;4925.482824303433;4928.753562321887;4934.185859333205;4935.136351138536;5354.303940487731;5491.093969495048;5563.415841336662;5569.331680198362;5633.971830140844;5539.944600553983;5554.72226388681;5556.222128901957;5569.331680198382;5582.91625625616;5250.7112108834;5521.4478552144865;5549.722513874331;5554.833354999336;5564;5200.843974680765;5213.687178769286;5325.121354976424;5348.946510534884;5365.436629153961;11747.647570572897;11772.646820595395;11826.462559867163;11915.463804128749;11938.164328497009;2204.9889750551306;2232.36377632374;2389.7610238976135;2668.2528891910297;2763.8065335426527;9981.75228096488;10174.44040577768;12441.440135193938;13628.454861805516;13897;1842.6867432536367;1906.094605062598;1912.4453908366556;1947.4157752674282;1973.4770285874256;77318.22681773223;79001;79872;81155.18844811476;81167;9259.907400925904;9598.9040109598;9997.600095996078;10133.277342851732;10253.897461025443;12570.371481426075;13201.47194112244;13770.65573360674;13870.237136957565;13873.791893121612;5664.122061080539;5790.507806836466;6187.84530386744;7088.468364872655;7103.502754807114;6678.833029174212;6715.764948226886;6822.147231596051;6985.860282794316;7508.3993280537425;4185.121124563876;4248.383984322256;4253.404523366731;4326.610605045561;4398.3842262083335;1729.6108375615638;1779.4038996935913;1790.85673146148;1820.1081470079566;1867.2437662746609;997.546116516983;1039.9496508526443;1095.7863216672831;1097.401915955806;1111.5387114347454;18584.628307433777;18698.626027479648;18733.531661708294;18868.15093320804;19317.61364772697;1034.2966782587762;1043.4991204222015;1061.6443491430302;1073.3774410841693;1074.6292529077612;10579.94710026445;10879.184061195441;10899.887122519312;10941.45292735376;10942.507587158598;348063;350486;350810;351777;351829;86686;91753;99402;100667;103920.48039759752;1069;1094.3324572011068;1099.2580008494235;1106.1593189176283;1113.4210210690396;17112.401065962633;17259.7411038832;17265.22306496236;17498.91250543739;17538.123093845512;39993.80003099966;40293.59706402898;40623;40671;41064;55918.720406397704;57263.42736572581;57792.71103644455;59011.704941475014;59111.40888591231;7750.496217746054;8120.269175774209;8192.508449493049;8406.411551191359;8424.199701028638;9196.26429885621;13150;13518.662033448849;13624.318784060559;13730.176189428666;11657.358845263252;11760.764784704086;11962.043036557228;11979.940100299442;12025.218360806519;11487.597934072268;11645.068394528247;11667.35829529384;11764.297164637435;11902.880971190523;11129;11674.241174323643;11930.582429614922;12265.816012759637;12456.190347627375;8056.436049476481;8258.752237432887;8308.418410711192;8350.081491036102;8350.707725229588;11002.724931876766;11871.406429678655;12001.459934302802;12346.938265308616;12488.313142777235 05:22:24 INFO - PROCESS | 19082 | |3;mootools.html;1514.772784082388;1543.5986643472697;1695.7710709054281;1752.3779058434263;1817.0642119308566;7331.9266807331915;7730.304272615464;7776.066871975364;7950.165232650568;8005.519668819868;7745.419093567991;7772.844543109134;7798.571078590675;7829.138794732575;7833.412494062954;2195.890205489727;2226.8441209115367;2230.2751605728204;2234.497238121418;2240.5518896220738;2148.763636000039;2161.167950339115;2162.956740865182;2180.2805074325515;2185.983517664286;2195.4182141732454;2213.4798322394226;2218.3455880515207;2224.555088982202;2237.2617036377956;2149.355193441969;2150.1721837092678;2163.286115581854;2166.99234855792;2167.3606286145546;2102.57948410317;2103.621348157331;2111.429913923232;2118.9617087626953;2121.3847984084596;7832.608369581555;7900.446968712193;7954.284114429671;7954.403419743542;8000.119986801447;4586.2661974083985;4756.215224487955;4766.356541866873;4768.117898188846;4779.068081724065;3213.5822343095247;3254;3296.884609038696;3375.9662403375896;3412.8293585320885;1168;1171.9569583071072;1172.8006238939402;1185.6502331812137;1194.9820752688718;11033.337999720043;11039.83440248397;11109.277896936674;11127.888721112766;11127.888721112848;4135.379693046007;4190.308599081118;4330.870073897788;4353.238183317907;4373.212821692063;9525.428474291564;9538.141567258841;9554.522273886418;9585.808283834423;9588.712338629852;4991.625628077909;4992.475790041994;5015.996800639887;5017.147084995559;5024.171011783088;4056.290149223874;4411.316245981878;4514.0971805639;4540.523245059221;4556.248219043887;3732;3733.757305775116;3828.8468461261796;3828.9617103828605;3831.4061320495366;1240.503798480597;1244.7448273103992;1247.0647014738945;1248.4007676315239;1252.3049707412292;860.6600392844791;950.4487397309543;951.9619215231452;982.1651596143221;1012.336919317848;5605.467480589337;5612.130119831432;5662.292213473316;5663.433656634386;5745.712714364265;406.2991339938582;407.12671320018393;407.57001363561136;412.42878613120445;420.4114240063874;3985.4221137934837;4070.226656935232;4070.9389359159636;4085.632293093636;4139.523954745183;9688.12806847387;9896.950515247378;10020.048095431068;10038.548265328078;10124.69625911224;9929.404235745878;9963.302568820112;10089.495525223709;10093.697189084192;10100.545475453622;7600.961995189989;7610;7622.58075805825;7647.847043059108;7763.029621297225;5617.073182924772;5664.819119136905;5671.376148623565;5761.91357129635;5777.873314703593;8755.387122901591;8898;9036;9108.453492790453;9220.815583688423;8940.15068568485;8991.730248092306;9063.184313411824;9119.361644684808;9461.952690236505;6602.966985165043;7042.50702450844;7051.6474176292;7197.316254955771;7290.453216008715;7766.495177813424;7825.060992680915;7828.765137045898;7838.490498117832;7853.45025848208;6937.89593156093;7119.181294151239;7135.714571417293;7208.315210055036;7240.927590724025;6961.199462061928;7096.290370962863;7098.680559374944;7197.46019048563;7238.493305468567;6319.652419116993;6419.711113000019;6424.839379015562;6432.324605916311;6439.774607888701;5086.7710953007945;5138.229265610188;5139.537441630271;5150.716710580954;5151.098557752453;5159;5193.896122077462;5251.474852514718;5258.158694608845;5360.517553420211 05:22:24 INFO - PROCESS | 19082 | |4;prototype.html;316.7750896863227;323.09855503146224;323.2645730962062;333.39655224044463;334.2145957001048;5866.2080619116405;5999.910001349972;6031.9999999999945;6069.908951365733;6107.053406721954;6047.758089676418;6048.939510604892;6052.818415447533;6070.757169713206;6080.483158931496;4610.262358022717;4616.884577885546;4617.330487079372;4619.445666520022;4635.698679585825;4270.466191726035;4499.10017996402;4509.684322097454;4533;4622.191116554606;4439.489458712241;4442.888927776799;4464.8883777905485;4470.217711900421;4472.195004899117;4435.379046933415;4463.509014008457;4464.6651501137385;4473.46318441789;4478.529754375776;3768.5289338832645;3843.7501562398634;3868.4197370394386;3954.5452272988687;3963.088489647397;5750.511206547449;5755.539556835485;5762.855928601776;5782.306123265193;5802.419758024206;5248.107821670325;5276.498732620395;5290;5291.074062039128;5301.151815709468;5939.46544810969;6218.440340369343;6263.467605253559;6266.057522168143;6318.704665543552;4303.978480107579;4342.50061242958;4344.044310251739;4344.804483798237;4346.15250026245;6197.194364732556;6512.609243445361;6515.7067931943175;6569.704363303663;6591.143151390289;4219.472565929259;4231.978840105779;4237.957620423818;4244.745315281031;4267.679924005712;4250.702450828474;4273.764942928106;4292;4294.785260737013;4295.699301048897;5076.035553244872;5123.872747995435;5131.409887862869;5131.409887862944;5140.922886156711;6163.445289923929;6268.216472940882;6381.872362552723;6385.201849768779;6404.807855764335;1598.9200539972956;1607.2044338052506;1615.7414813629762;1617.5147455763224;1618.2070785315111;1025.6564051042835;1041.8280983637615;1046.1735229168871;1051.295631926611;1056.5245639462273;6094.786682466092;6111.96944015277;6115.143879856823;6122.173506576644;6134.8159555213415;6505.544611877123;6528.477721782246;6545.639989800511;6562.475001999828;6568.507361947873;5907.645541267538;6035.818925432244;6052.6671033092725;6081.543884208702;6082.118092876508;3497.8600855965983;3506.386382383124;3512.841922113511;3527.9294414111573;3546.6453354664327;6605.86788264232;6729.663516824139;6744.494162937701;6773.221079575912;6787.626680532618;6686.7993960181275;6691.966540167366;6715.608617648057;6730.360615741497;6732.004258105097;6643.833904152339;6651.63416012124;6743.797686069426;6776.273049822578;6787.1176747023555;6487.448566871869;6488.351164883474;6512.218533775977;6517.250516190698;6539.7384104637185;6290.591111577733;6309.432151106423;6447.484201263981;6448.484121270193;6475.838104047248;6665.866682666417;6682;6723.798286051427;6731.562448440835;6735.49483788708;4452.354408610798;4465.151621191963;4478.731276123443;4484.798184081659;4491.270860718712;6243.157173781663;6412.711427985659;6506.41442270198;6626.171728533934;6630.668466576748;6388.744450222125;6427.132337134614;6431.871362572816;6457.3865482779065;6464.5798023128345;6241.375862413723;6348.174737284124;6382.489400847828;6435.4529864962005;6461.224653041665;6267.4045965633195;6276.152719382825;6285.277193122849;6294.24469063697;6322.430981211713;6400.167978162809;6447.838804029937;6459.935400645933;6477.51418643613;6480.319566445644;6163;6176.505879529537;6311.779087731908;6317.4630156437215;6342.207224096988 05:22:24 INFO - PROCESS | 19082 | |5;yui.html;803.204827221051;810.1210186947162;843.8438888805572;848.8047749017726;859.5831021954347;12749.681257968556;14027;14085.718285634293;14096.365663545139;14116.647083822909;13165.80251296229;13179.077464577484;13228.206307621549;13237.933810330935;13295.734085318289;690.5373399822131;798.1579433697447;815.9428839981189;826.3348004856089;838.3000194837318;829.7510746775973;834.0658462521953;834.8539005673982;837.4054421360842;840.231188462556;861.2464093917822;863.201538576817;865.8960924689046;868.3704314372093;871.6687658689689;856.4818284937617;856.5631527920774;864.2610567964425;864.5331520978664;868.079835374505;631.8578319878037;632.3202557250928;634.5241069198102;635.5233574818886;636.4494712074069;13053.216806991612;13058.412371443308;13063;13087.345632718327;13096.934515327363;13488.325583720774;13545.187288762607;13568.1859088455;13623.863761362358;13657.453701852013;11937.701557461047;12134.696632584257;12316.261024338479;12446.190997585129;12657.620271391874;4545.795439205211;4564.703294285894;4575.565321294472;4639.837605683785;4682.672212945095;53313.733431332985;53668;55731.16403253954;55793.72103139499;56116.719416403066;10284.588616455258;10389.272750907365;10530.736731581772;10557.102646275152;10774.138068954464;18109.909450452928;18234.908825455786;18247;18273;18327.54181145482;8077.151899050633;8087.555184464911;8140.145284745135;8220.547869867096;8279.047909490366;4391.429114215131;4397.538258482878;4411.051623900877;4522.841700540531;4608.5621865922685;3042.771792115556;3126.937461250762;3135.106494649014;3135.5139953307275;3146.8111913285275;586.0535235594484;588.885167392363;594.0910407077179;600.0788789208544;608.9878202435926;605.8909396308707;639.3925770517933;639.667372966055;762.4091329219788;767.5202998126172;8457.112003239572;8505.234528892306;8629.61166747498;8906.287497000225;9118.179363857285;549.1433363952248;625.515225700086;670.2058061197497;676.9153855768029;680.5678394219706;3827.8086095695103;4097.836086556564;4194.601512856274;4219.894502637398;4241.660667146621;50823;55088.72455637696;55700;55859.72070139705;62094.37905620886;48340.5165948336;51219;52345.7382713084;53019.46980530145;54509;46956.5304346959;47059.764701176275;47603;48459;49263.75368123136;8446.324294056338;8514.61684224199;8560.272376848037;8786.341024423322;8801.427907186013;23887.64168537508;24709.50580988406;24840.875795620905;28044.579331310455;32031.519527207576;45584.316235255836;45911.54088459073;46264.768676156404;46501;46568.53431465642;10881.07510861554;10882.40146791934;11002.229843910849;11032.503537340679;11088.16838737114;11577.826332604849;11582.594609188638;11901.76196476083;11940.10449216295;12682.302473363685;11543.19197656156;12047.939760301142;12087.274763514217;12105.576304829288;12131.272123672255;11656.766864662828;11659.30044197317;12052.216605920587;12458.377081146087;12466.563670271496;12204.511819527119;12259.448324825225;12312.445939932546;12452.937735311265;12929.54746583865;9821;9930.801383972424;10026.197904167795;10040.69877903664;10118.544665490217;10028.449147771023;10029.648962286285;10176.694699159038;10362.430066346424;10570.947145264225 05:22:24 INFO - PROCESS | 19082 | __end_tp_report 05:22:24 INFO - PROCESS | 19082 | __start_cc_report 05:22:24 INFO - PROCESS | 19082 | _x_x_mozilla_cycle_collect,333 05:22:24 INFO - PROCESS | 19082 | __end_cc_report 05:22:24 INFO - PROCESS | 19082 | __startTimestamp1461154944651__endTimestamp 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | ------- Summary: start ------- 05:22:24 INFO - PROCESS | 19082 | Number of tests: 6 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | [#0] dojo.html Cycles:165 Average:5346.78 Median:5538.70 stddev:598.02 (10.8%) stddev-sans-first:574.04 05:22:24 INFO - PROCESS | 19082 | Values: 3131.1 3177.8 3182.7 3210.2 3220.1 5377.2 5395.2 5407.8 5443.7 5460.5 5255.6 5328.0 5356.8 5368.3 5392.1 4875.3 4905.1 4906.6 4954.9 4962.7 4829.5 5037.7 5051.2 5062.5 5067.1 4860.8 4943.0 4943.2 4966.0 4985.2 4847.2 4888.2 4894.8 4895.1 4919.2 4860.6 4866.1 4885.9 4891.5 4936.7 5184.7 5240.6 5307.2 5312.4 5314.0 5603.2 5611.1 5616.6 5632.3 5651.0 5611.7 5663.9 5680.8 5684.1 5712.5 5268.0 5297.3 5298.0 5330.9 5350.1 5899.3 5902.4 5945.9 5948.3 5959.9 5496.1 5626.7 5645.8 5716.9 5738.6 5778.4 5779.3 5783.5 5785.2 5832.9 5651.5 5670.9 5747.9 5752.9 5753.9 5571.1 5695.8 5752.7 5753.1 5793.0 4310.5 4343.2 4345.3 4363.5 4381.5 3922.3 3933.2 3935.4 3948.7 3965.3 5473.0 5530.6 5530.9 5533.1 5538.7 5686.4 5710.1 5712.4 5714.5 5729.5 5429.7 5430.1 5445.1 5445.4 5459.8 4821.0 4947.0 4974.8 5020.8 5047.1 5994.2 6002.3 6014.9 6028.3 6036.6 5806.8 5817.4 5819.3 5846.2 5849.6 5926.2 5942.4 5983.1 6003.6 6033.4 5692.6 5707.7 5710.8 5719.9 5741.7 5615.4 5792.2 5826.4 5832.1 5839.9 5532.3 5586.0 5599.8 5615.2 5645.5 5554.4 5620.4 5669.7 5675.1 5688.5 5501.1 5571.5 5586.0 5593.5 5595.6 5571.7 5637.5 5720.8 5737.5 5763.0 5430.7 5433.1 5442.1 5463.6 5476.0 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | [#1] ext.html Cycles:180 Average:51591.72 Median:38974.81 stddev:100701.20 (258.4%) stddev-sans-first:100910.95 05:22:24 INFO - PROCESS | 19082 | Values: 611.6 645.0 656.6 685.9 724.5 35866.5 37337.3 37365.8 37474.4 37491.4 39941.6 40569.8 40649.6 40703.0 40821.0 8515.6 8676.4 8717.7 8728.3 8735.6 8551.7 8619.1 8634.8 8644.1 8679.7 8589.3 8666.4 8691.1 8716.5 8732.6 8648.4 8675.5 8702.5 8706.1 8731.8 8378.6 8626.7 8645.6 8653.4 8697.5 33205.7 38377.6 38684.0 38845.4 39029.8 3282.5 3318.4 3331.0 3342.2 3376.3 27035.5 27131.6 27662.4 27793.2 27901.3 4071.2 4130.2 4133.7 4158.0 4339.9 193720.0 194213.0 194228.0 195008.0 228508.0 34441.3 34548.7 34627.5 35285.8 36239.5 34637.0 34658.8 34680.3 34833.3 34885.5 13249.8 13384.6 13393.5 13438.8 13505.2 10964.6 11027.6 11030.9 11036.5 11053.4 8297.8 8324.5 8335.9 8390.3 8399.1 3222.4 3233.9 3256.9 3264.8 3283.1 1058.2 1111.8 1172.8 1178.9 1233.6 31290.0 31397.4 31412.4 31552.8 32478.0 1183.6 1186.6 1188.5 1261.2 1322.3 16789.7 16858.0 17014.0 17062.6 17228.0 456974.0 461471.0 463342.0 463911.0 464797.0 57237.7 57836.7 57994.4 58001.0 58189.7 1391.2 1402.9 1414.0 1426.5 1429.7 29654.4 30860.8 32812.2 34531.3 34600.7 55439.0 56683.4 56976.7 56994.7 57172.0 414499.0 419850.0 420828.0 421205.0 422719.0 42066.8 42682.8 43271.0 43671.0 43716.8 48248.0 48343.5 48630.0 50045.0 50345.7 39201.0 39701.6 40039.4 40233.8 41245.4 38919.8 40023.4 40292.6 40618.6 41148.6 36591.5 41119.6 42283.6 43491.8 43543.1 30734.7 33507.8 33849.7 33918.7 33968.7 27154.0 27467.9 27895.0 28006.6 28240.9 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | [#2] jquery.html Cycles:180 Average:24488.49 Median:2089.23 stddev:59091.42 (2828.4%) stddev-sans-first:59229.48 05:22:24 INFO - PROCESS | 19082 | Values: 384.9 388.3 394.4 395.7 401.8 14538.3 17172.0 17889.6 18462.4 18605.4 11062.2 11720.4 11748.0 18410.2 18555.9 4787.1 4925.5 4928.8 4934.2 4935.1 5354.3 5491.1 5563.4 5569.3 5634.0 5539.9 5554.7 5556.2 5569.3 5582.9 5250.7 5521.4 5549.7 5554.8 5564.0 5200.8 5213.7 5325.1 5348.9 5365.4 11747.6 11772.6 11826.5 11915.5 11938.2 2205.0 2232.4 2389.8 2668.3 2763.8 9981.8 10174.4 12441.4 13628.5 13897.0 1842.7 1906.1 1912.4 1947.4 1973.5 77318.2 79001.0 79872.0 81155.2 81167.0 9259.9 9598.9 9997.6 10133.3 10253.9 12570.4 13201.5 13770.7 13870.2 13873.8 5664.1 5790.5 6187.8 7088.5 7103.5 6678.8 6715.8 6822.1 6985.9 7508.4 4185.1 4248.4 4253.4 4326.6 4398.4 1729.6 1779.4 1790.9 1820.1 1867.2 997.5 1039.9 1095.8 1097.4 1111.5 18584.6 18698.6 18733.5 18868.2 19317.6 1034.3 1043.5 1061.6 1073.4 1074.6 10579.9 10879.2 10899.9 10941.5 10942.5 348063.0 350486.0 350810.0 351777.0 351829.0 86686.0 91753.0 99402.0 100667.0 103920.5 1069.0 1094.3 1099.3 1106.2 1113.4 17112.4 17259.7 17265.2 17498.9 17538.1 39993.8 40293.6 40623.0 40671.0 41064.0 55918.7 57263.4 57792.7 59011.7 59111.4 7750.5 8120.3 8192.5 8406.4 8424.2 9196.3 13150.0 13518.7 13624.3 13730.2 11657.4 11760.8 11962.0 11979.9 12025.2 11487.6 11645.1 11667.4 11764.3 11902.9 11129.0 11674.2 11930.6 12265.8 12456.2 8056.4 8258.8 8308.4 8350.1 8350.7 11002.7 11871.4 12001.5 12346.9 12488.3 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | [#3] mootools.html Cycles:180 Average:5363.12 Median:5020.66 stddev:2964.68 (59.0%) stddev-sans-first:2958.90 05:22:24 INFO - PROCESS | 19082 | Values: 1514.8 1543.6 1695.8 1752.4 1817.1 7331.9 7730.3 7776.1 7950.2 8005.5 7745.4 7772.8 7798.6 7829.1 7833.4 2195.9 2226.8 2230.3 2234.5 2240.6 2148.8 2161.2 2163.0 2180.3 2186.0 2195.4 2213.5 2218.3 2224.6 2237.3 2149.4 2150.2 2163.3 2167.0 2167.4 2102.6 2103.6 2111.4 2119.0 2121.4 7832.6 7900.4 7954.3 7954.4 8000.1 4586.3 4756.2 4766.4 4768.1 4779.1 3213.6 3254.0 3296.9 3376.0 3412.8 1168.0 1172.0 1172.8 1185.7 1195.0 11033.3 11039.8 11109.3 11127.9 11127.9 4135.4 4190.3 4330.9 4353.2 4373.2 9525.4 9538.1 9554.5 9585.8 9588.7 4991.6 4992.5 5016.0 5017.1 5024.2 4056.3 4411.3 4514.1 4540.5 4556.2 3732.0 3733.8 3828.8 3829.0 3831.4 1240.5 1244.7 1247.1 1248.4 1252.3 860.7 950.4 952.0 982.2 1012.3 5605.5 5612.1 5662.3 5663.4 5745.7 406.3 407.1 407.6 412.4 420.4 3985.4 4070.2 4070.9 4085.6 4139.5 9688.1 9897.0 10020.0 10038.5 10124.7 9929.4 9963.3 10089.5 10093.7 10100.5 7601.0 7610.0 7622.6 7647.8 7763.0 5617.1 5664.8 5671.4 5761.9 5777.9 8755.4 8898.0 9036.0 9108.5 9220.8 8940.2 8991.7 9063.2 9119.4 9462.0 6603.0 7042.5 7051.6 7197.3 7290.5 7766.5 7825.1 7828.8 7838.5 7853.5 6937.9 7119.2 7135.7 7208.3 7240.9 6961.2 7096.3 7098.7 7197.5 7238.5 6319.7 6419.7 6424.8 6432.3 6439.8 5086.8 5138.2 5139.5 5150.7 5151.1 5159.0 5193.9 5251.5 5258.2 5360.5 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | [#4] prototype.html Cycles:180 Average:5270.68 Median:6070.33 stddev:1613.00 (26.6%) stddev-sans-first:1574.08 05:22:24 INFO - PROCESS | 19082 | Values: 316.8 323.1 323.3 333.4 334.2 5866.2 5999.9 6032.0 6069.9 6107.1 6047.8 6048.9 6052.8 6070.8 6080.5 4610.3 4616.9 4617.3 4619.4 4635.7 4270.5 4499.1 4509.7 4533.0 4622.2 4439.5 4442.9 4464.9 4470.2 4472.2 4435.4 4463.5 4464.7 4473.5 4478.5 3768.5 3843.8 3868.4 3954.5 3963.1 5750.5 5755.5 5762.9 5782.3 5802.4 5248.1 5276.5 5290.0 5291.1 5301.2 5939.5 6218.4 6263.5 6266.1 6318.7 4304.0 4342.5 4344.0 4344.8 4346.2 6197.2 6512.6 6515.7 6569.7 6591.1 4219.5 4232.0 4238.0 4244.7 4267.7 4250.7 4273.8 4292.0 4294.8 4295.7 5076.0 5123.9 5131.4 5131.4 5140.9 6163.4 6268.2 6381.9 6385.2 6404.8 1598.9 1607.2 1615.7 1617.5 1618.2 1025.7 1041.8 1046.2 1051.3 1056.5 6094.8 6112.0 6115.1 6122.2 6134.8 6505.5 6528.5 6545.6 6562.5 6568.5 5907.6 6035.8 6052.7 6081.5 6082.1 3497.9 3506.4 3512.8 3527.9 3546.6 6605.9 6729.7 6744.5 6773.2 6787.6 6686.8 6692.0 6715.6 6730.4 6732.0 6643.8 6651.6 6743.8 6776.3 6787.1 6487.4 6488.4 6512.2 6517.3 6539.7 6290.6 6309.4 6447.5 6448.5 6475.8 6665.9 6682.0 6723.8 6731.6 6735.5 4452.4 4465.2 4478.7 4484.8 4491.3 6243.2 6412.7 6506.4 6626.2 6630.7 6388.7 6427.1 6431.9 6457.4 6464.6 6241.4 6348.2 6382.5 6435.5 6461.2 6267.4 6276.2 6285.3 6294.2 6322.4 6400.2 6447.8 6459.9 6477.5 6480.3 6163.0 6176.5 6311.8 6317.5 6342.2 05:22:24 INFO - PROCESS | 19082 | 05:22:24 INFO - PROCESS | 19082 | [#5] yui.html Cycles:180 Average:14065.30 Median:25243.55 stddev:16199.51 (64.2%) stddev-sans-first:16214.34 05:22:24 INFO - PROCESS | 19082 | Values: 803.2 810.1 843.8 848.8 859.6 12749.7 14027.0 14085.7 14096.4 14116.6 13165.8 13179.1 13228.2 13237.9 13295.7 690.5 798.2 815.9 826.3 838.3 829.8 834.1 834.9 837.4 840.2 861.2 863.2 865.9 868.4 871.7 856.5 856.6 864.3 864.5 868.1 631.9 632.3 634.5 635.5 636.4 13053.2 13058.4 13063.0 13087.3 13096.9 13488.3 13545.2 13568.2 13623.9 13657.5 11937.7 12134.7 12316.3 12446.2 12657.6 4545.8 4564.7 4575.6 4639.8 4682.7 53313.7 53668.0 55731.2 55793.7 56116.7 10284.6 10389.3 10530.7 10557.1 10774.1 18109.9 18234.9 18247.0 18273.0 18327.5 8077.2 8087.6 8140.1 8220.5 8279.0 4391.4 4397.5 4411.1 4522.8 4608.6 3042.8 3126.9 3135.1 3135.5 3146.8 586.1 588.9 594.1 600.1 609.0 605.9 639.4 639.7 762.4 767.5 8457.1 8505.2 8629.6 8906.3 9118.2 549.1 625.5 670.2 676.9 680.6 3827.8 4097.8 4194.6 4219.9 4241.7 50823.0 55088.7 55700.0 55859.7 62094.4 48340.5 51219.0 52345.7 53019.5 54509.0 46956.5 47059.8 47603.0 48459.0 49263.8 8446.3 8514.6 8560.3 8786.3 8801.4 23887.6 24709.5 24840.9 28044.6 32031.5 45584.3 45911.5 46264.8 46501.0 46568.5 10881.1 10882.4 11002.2 11032.5 11088.2 11577.8 11582.6 11901.8 11940.1 12682.3 11543.2 12047.9 12087.3 12105.6 12131.3 11656.8 11659.3 12052.2 12458.4 12466.6 12204.5 12259.4 12312.4 12452.9 12929.5 9821.0 9930.8 10026.2 10040.7 10118.5 10028.4 10029.6 10176.7 10362.4 10570.9 05:22:24 INFO - PROCESS | 19082 | -------- Summary: end -------- 05:22:24 INFO - PROCESS | 19082 | 05:22:25 INFO - TEST-INFO | 19082: exit 0 05:22:25 INFO - TEST-OK | dromaeo_css | took 1110776ms 05:22:25 INFO - TEST-START | kraken 05:22:25 INFO - operating with platform_type : linux_ 05:22:25 INFO - Initialising browser for kraken test... 05:22:25 INFO - TEST-INFO | started process 19319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUGBNQf/profile http://localhost:41959/getInfo.html) 05:22:29 INFO - PROCESS | 19319 | 05:22:29 INFO - PROCESS | 19319 | (process:19386): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:22:29 INFO - PROCESS | 19319 | __metrics Screen width/height:1600/1200 05:22:29 INFO - PROCESS | 19319 | colorDepth:24 05:22:29 INFO - PROCESS | 19319 | Browser inner width/height: 1024/697 05:22:29 INFO - PROCESS | 19319 | __metrics 05:22:30 ERROR - PROCESS | 19319 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:22:31 INFO - TEST-INFO | 19319: exit 0 05:22:31 INFO - Browser initialized. 05:22:31 INFO - Running cycle 1/1 for kraken test... 05:22:31 INFO - TEST-INFO | started process 19437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUGBNQf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:33 INFO - PROCESS | 19437 | 05:22:33 INFO - PROCESS | 19437 | (process:19497): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:22:43 INFO - PROCESS | 19437 | RSS: Main: 163479552 05:22:43 INFO - PROCESS | 19437 | 05:22:45 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41959/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:46 INFO - PROCESS | 19437 | RSS: Main: 168153088 05:22:46 INFO - PROCESS | 19437 | 05:22:49 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41959/tests/kraken/driver.html?testName=audio-dft) 05:22:49 INFO - PROCESS | 19437 | RSS: Main: 171180032 05:22:49 INFO - PROCESS | 19437 | 05:22:52 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41959/tests/kraken/driver.html?testName=audio-fft) 05:22:53 INFO - PROCESS | 19437 | RSS: Main: 163794944 05:22:53 INFO - PROCESS | 19437 | 05:22:55 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41959/tests/kraken/driver.html?testName=audio-oscillator) 05:22:56 INFO - PROCESS | 19437 | RSS: Main: 164364288 05:22:56 INFO - PROCESS | 19437 | 05:22:58 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:58 INFO - PROCESS | 19437 | RSS: Main: 164139008 05:22:58 INFO - PROCESS | 19437 | 05:23:02 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41959/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:02 INFO - PROCESS | 19437 | RSS: Main: 164732928 05:23:02 INFO - PROCESS | 19437 | 05:23:06 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41959/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:06 INFO - PROCESS | 19437 | RSS: Main: 164737024 05:23:06 INFO - PROCESS | 19437 | 05:23:09 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41959/tests/kraken/driver.html?testName=json-parse-financial) 05:23:10 INFO - PROCESS | 19437 | RSS: Main: 164818944 05:23:10 INFO - PROCESS | 19437 | 05:23:11 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:12 INFO - PROCESS | 19437 | RSS: Main: 164741120 05:23:12 INFO - PROCESS | 19437 | 05:23:14 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:14 INFO - PROCESS | 19437 | RSS: Main: 165109760 05:23:14 INFO - PROCESS | 19437 | 05:23:16 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:17 INFO - PROCESS | 19437 | RSS: Main: 165376000 05:23:17 INFO - PROCESS | 19437 | 05:23:20 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:20 INFO - PROCESS | 19437 | RSS: Main: 165896192 05:23:20 INFO - PROCESS | 19437 | 05:23:23 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:24 INFO - PROCESS | 19437 | RSS: Main: 165851136 05:23:24 INFO - PROCESS | 19437 | 05:23:25 INFO - PROCESS | 19437 | Cycle 1(1): loaded http://localhost:41959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41959/tests/kraken/driver.html?testName=ai-astar) 05:23:26 INFO - PROCESS | 19437 | RSS: Main: 167104512 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | __start_tp_report 05:23:26 INFO - PROCESS | 19437 | _x_x_mozilla_page_load 05:23:26 INFO - PROCESS | 19437 | _x_x_mozilla_page_load_details 05:23:26 INFO - PROCESS | 19437 | |i|pagename|runs| 05:23:26 INFO - PROCESS | 19437 | |0;ai-astar;113;105;112;111;112;123;112;112;112;113 05:23:26 INFO - PROCESS | 19437 | |1;audio-beat-detection;166;127;151;182;133;150;154;130;190;128 05:23:26 INFO - PROCESS | 19437 | |2;audio-dft;162;161;162;161;164;163;173;162;166;163 05:23:26 INFO - PROCESS | 19437 | |3;audio-fft;76;77;76;158;74;74;77;74;172;77 05:23:26 INFO - PROCESS | 19437 | |4;audio-oscillator;96;93;152;93;93;93;147;94;93;148 05:23:26 INFO - PROCESS | 19437 | |5;imaging-gaussian-blur;117;119;117;117;118;117;118;118;119;119 05:23:26 INFO - PROCESS | 19437 | |6;imaging-darkroom;148;146;147;148;146;147;147;147;147;147 05:23:26 INFO - PROCESS | 19437 | |7;imaging-desaturate;96;97;96;95;95;96;95;95;96;95 05:23:26 INFO - PROCESS | 19437 | |8;json-parse-financial;57;59;58;58;57;58;58;78;59;54 05:23:26 INFO - PROCESS | 19437 | |9;json-stringify-tinderbox;64;65;65;64;65;65;65;64;64;64 05:23:26 INFO - PROCESS | 19437 | |10;stanford-crypto-aes;75;84;76;76;86;76;77;77;78;78 05:23:26 INFO - PROCESS | 19437 | |11;stanford-crypto-ccm;142;129;129;134;142;129;125;126;162;126 05:23:26 INFO - PROCESS | 19437 | |12;stanford-crypto-pbkdf2;164;163;168;162;163;174;165;169;161;166 05:23:26 INFO - PROCESS | 19437 | |13;stanford-crypto-sha256-iterative;70;69;69;68;71;67;66;70;67;68 05:23:26 INFO - PROCESS | 19437 | __end_tp_report 05:23:26 INFO - PROCESS | 19437 | __start_cc_report 05:23:26 INFO - PROCESS | 19437 | _x_x_mozilla_cycle_collect,857 05:23:26 INFO - PROCESS | 19437 | __end_cc_report 05:23:26 INFO - PROCESS | 19437 | __startTimestamp1461155006114__endTimestamp 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | ------- Summary: start ------- 05:23:26 INFO - PROCESS | 19437 | Number of tests: 14 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.35 (3.9%) stddev-sans-first:4.61 05:23:26 INFO - PROCESS | 19437 | Values: 113.0 105.0 112.0 111.0 112.0 123.0 112.0 112.0 112.0 113.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:152.50 stddev:22.58 (14.8%) stddev-sans-first:23.29 05:23:26 INFO - PROCESS | 19437 | Values: 166.0 127.0 151.0 182.0 133.0 150.0 154.0 130.0 190.0 128.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.59 (2.2%) stddev-sans-first:3.76 05:23:26 INFO - PROCESS | 19437 | Values: 162.0 161.0 162.0 161.0 164.0 163.0 173.0 162.0 166.0 163.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:37.85 (49.8%) stddev-sans-first:39.61 05:23:26 INFO - PROCESS | 19437 | Values: 76.0 77.0 76.0 158.0 74.0 74.0 77.0 74.0 172.0 77.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:93.00 stddev:26.82 (28.8%) stddev-sans-first:27.95 05:23:26 INFO - PROCESS | 19437 | Values: 96.0 93.0 152.0 93.0 93.0 93.0 147.0 94.0 93.0 148.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 05:23:26 INFO - PROCESS | 19437 | Values: 117.0 119.0 117.0 117.0 118.0 117.0 118.0 118.0 119.0 119.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 05:23:26 INFO - PROCESS | 19437 | Values: 148.0 146.0 147.0 148.0 146.0 147.0 147.0 147.0 147.0 147.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:23:26 INFO - PROCESS | 19437 | Values: 96.0 97.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:58.00 stddev:6.62 (11.4%) stddev-sans-first:6.95 05:23:26 INFO - PROCESS | 19437 | Values: 57.0 59.0 58.0 58.0 57.0 58.0 58.0 78.0 59.0 54.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:23:26 INFO - PROCESS | 19437 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 65.0 64.0 64.0 64.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.50 stddev:3.68 (4.8%) stddev-sans-first:3.71 05:23:26 INFO - PROCESS | 19437 | Values: 75.0 84.0 76.0 76.0 86.0 76.0 77.0 77.0 78.0 78.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:131.50 stddev:11.52 (8.8%) stddev-sans-first:11.89 05:23:26 INFO - PROCESS | 19437 | Values: 142.0 129.0 129.0 134.0 142.0 129.0 125.0 126.0 162.0 126.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:3.92 (2.4%) stddev-sans-first:4.12 05:23:26 INFO - PROCESS | 19437 | Values: 164.0 163.0 168.0 162.0 163.0 174.0 165.0 169.0 161.0 166.0 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - PROCESS | 19437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.58 05:23:26 INFO - PROCESS | 19437 | Values: 70.0 69.0 69.0 68.0 71.0 67.0 66.0 70.0 67.0 68.0 05:23:26 INFO - PROCESS | 19437 | -------- Summary: end -------- 05:23:26 INFO - PROCESS | 19437 | 05:23:26 INFO - TEST-INFO | 19437: exit 0 05:23:27 INFO - TEST-OK | kraken | took 61668ms 05:23:27 INFO - SUITE-END | took 1172s 05:23:27 INFO - Completed test suite (00:19:32) 05:23:27 INFO - javascript benchmark 05:23:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.138936792382, 3177.841107944601, 3182.7135557799793, 3210.2455922858107, 3220.0822765511834, 5377.220303056055, 5395.190721391788, 5407.83776486705, 5443.673379597227, 5460.453954604538, 5255.605829562779, 5327.973360133204, 5356.812511562086, 5368.275282836816, 5392.056390131721, 4875.317455556216, 4905.117078925792, 4906.632002599819, 4954.876128096808, 4962.702237865721, 4829.51704829516, 5037.697738135724, 5051.191809310511, 5062.544371006608, 5067.062593420229, 4860.8298709545, 4943.011397720452, 4943.184374578191, 4965.981973695384, 4985.202367621199, 4847.151748444044, 4888.2178851383605, 4894.755262236909, 4895.0944075345815, 4919.237518184687, 4860.586850117745, 4866.051120031595, 4885.926711099336, 4891.4863939286215, 4936.703797772145, 5184.662996905189, 5240.554552863011, 5307.203919412081, 5312.442193569696, 5314.0169068722025, 5603.159526071081, 5611.102223644238, 5616.634918730269, 5632.324121105453, 5651.0, 5611.663300202001, 5663.8584035399035, 5680.829575112753, 5684.062129748587, 5712.542996560265, 5268.0, 5297.258383826229, 5297.999999999962, 5330.946690533123, 5350.0904846176245, 5899.321578018497, 5902.3507414184405, 5945.910811337833, 5948.315943666534, 5959.910601340984, 5496.065668836308, 5626.746796394172, 5645.830625081254, 5716.885662286731, 5738.598298119092, 5778.3643799182055, 5779.335376431764, 5783.508401785895, 5785.190073389729, 5832.941670583325, 5651.463111004448, 5670.886582268332, 5747.8563035924435, 5752.884942301131, 5753.942460575425, 5571.1086226203615, 5695.772169113272, 5752.712364381848, 5753.108268218432, 5792.9710351447975, 4310.482742070972, 4343.1747967886, 4345.326474396474, 4363.4763828340165, 4381.452318460192, 3922.2939870822956, 3933.2330195612153, 3935.4490371348033, 3948.7038472114705, 3965.325894597868, 5473.0, 5530.640508366943, 5530.917036244459, 5533.142362933751, 5538.695371754511, 5686.402927692533, 5710.086386178192, 5712.428757124254, 5714.457126572969, 5729.48434640876, 5429.701366424884, 5430.104032834538, 5445.101558242845, 5445.401005889349, 5459.808906688327, 4820.975895120502, 4946.975265123651, 4974.751262436864, 5020.824271150492, 5047.116754568009, 5994.220751302303, 6002.279726432856, 6014.879702405928, 6028.2766068072115, 6036.577439579275, 5806.79676211339, 5817.418258174149, 5819.301683797971, 5846.210761547137, 5849.561282903885, 5926.2295901532525, 5942.405759424023, 5983.102534619842, 6003.609765365237, 6033.366496517978, 5692.601517893708, 5707.686077265625, 5710.8001219957105, 5719.8570035749435, 5741.684207368635, 5615.438456154352, 5792.160136780228, 5826.359100498857, 5832.096025116114, 5839.883202336015, 5532.28080349552, 5585.9720701397855, 5599.776008959596, 5615.241942337732, 5645.491905728504, 5554.416786237387, 5620.381758006534, 5669.659820410789, 5675.148727690879, 5688.459596338341, 5501.14732216507, 5571.526420254324, 5585.972070139624, 5593.468620481048, 5595.636283641713, 5571.66570005801, 5637.52081073097, 5720.799772007959, 5737.483626473638, 5763.049096898964, 5430.728463576885, 5433.130699088285, 5442.12925931849, 5463.562914966873, 5476.0], "value": 5307.351695581137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.6024584020386, 645.0260107238071, 656.5765081522417, 685.8696847598959, 724.4638967164296, 35866.462003069944, 37337.25325493488, 37365.813170934176, 37474.4378834317, 37491.4376284356, 39941.60058399415, 40569.797151014274, 40649.59350406495, 40703.0, 40821.0, 8515.574221288942, 8676.392652514327, 8717.651293948265, 8728.345374096969, 8735.606897689619, 8551.700690475835, 8619.138086191393, 8634.827303453927, 8644.135586441369, 8679.652813887436, 8589.26991205745, 8666.39335246533, 8691.130886911322, 8716.477011379306, 8732.563371831415, 8648.394612377137, 8675.479471231714, 8702.521361325125, 8706.085860984569, 8731.825363492759, 8378.622961966727, 8626.654933802703, 8645.567721613894, 8653.437526560754, 8697.47815131088, 33205.6679433205, 38377.61622383796, 38684.0, 38845.41731874024, 39029.80485097556, 3282.5404443377947, 3318.3529211803707, 3330.96669033309, 3342.181165614416, 3376.324735052999, 27035.45929081427, 27131.593026104623, 27662.44675106507, 27793.16620501368, 27901.302467438272, 4071.2061148076136, 4130.173965206971, 4133.7106402551835, 4157.958420415787, 4339.913201735948, 193720.0, 194213.0, 194228.0, 195008.0, 228508.0, 34441.31117377638, 34548.654513454545, 34627.4805877912, 35285.823570881985, 36239.4564081539, 34637.0, 34658.82670586631, 34680.30639387198, 34833.30333393318, 34885.476717849255, 13249.801252981213, 13384.598462046155, 13393.464261429628, 13438.798418023738, 13505.189688618519, 10964.56141754321, 11027.56641636582, 11030.944845275722, 11036.503357348938, 11053.392063436428, 8297.751067467985, 8324.542150181798, 8335.874961875577, 8390.286825619769, 8399.076101628816, 3222.371637530659, 3233.854476548561, 3256.9022929311686, 3264.755143364257, 3283.097148284241, 1058.1588036815886, 1111.8054340490544, 1172.7888979983513, 1178.9250918383534, 1233.5620854596668, 31290.0, 31397.37205255882, 31412.37175256528, 31552.842235788674, 32478.0, 1183.5798291606527, 1186.5965571705663, 1188.5127097889824, 1261.1863467173473, 1322.2793577500286, 16789.6642067158, 16858.0, 17013.979161250365, 17062.573435664206, 17228.0, 456974.0, 461471.0, 463342.0, 463911.0, 464797.0, 57237.71381143068, 57836.71081644565, 57994.42005579975, 58001.0, 58189.70905145447, 1391.1583491987403, 1402.9438822447191, 1413.9787903181461, 1426.5363756778881, 1429.742646323651, 29654.406911862072, 30860.84569577138, 32812.1796955078, 34531.30937381289, 34600.65399346075, 55439.0, 56683.43316566782, 56976.71511642415, 56994.7150264246, 57172.0, 414499.0, 419850.0, 420828.0, 421205.0, 422719.0, 42066.789666051474, 42682.78658606687, 43271.0, 43671.0, 43716.814159292546, 48248.0, 48343.5165648339, 48630.0, 50045.0, 50345.74827125841, 39201.0, 39701.602983970944, 40039.39940900947, 40233.79883100566, 41245.38131928084, 38919.805400972815, 40023.36460262646, 40292.59707402888, 40618.59381406148, 41148.588514114475, 36591.45112823363, 41119.58880411277, 42283.577164229195, 43491.782541087094, 43543.12913741771, 30734.69265307408, 33507.83246083754, 33849.661503385636, 33918.66081339254, 33968.66031339655, 27154.0, 27467.86266068657, 27895.0, 28006.579901301906, 28240.85879570589], "value": 18123.86557155919, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.85375557288233, 388.2913682529383, 394.4302866822649, 395.71508513870003, 401.7609522334211, 14538.34577444015, 17172.0, 17889.55276118096, 18462.353817616386, 18605.441836744885, 11062.22564420491, 11720.413979301044, 11748.0, 18410.171542280597, 18555.907220463912, 4787.138315103271, 4925.482824303433, 4928.753562321887, 4934.185859333205, 4935.136351138536, 5354.303940487731, 5491.093969495048, 5563.415841336662, 5569.331680198362, 5633.971830140844, 5539.944600553983, 5554.72226388681, 5556.222128901957, 5569.331680198382, 5582.91625625616, 5250.7112108834, 5521.4478552144865, 5549.722513874331, 5554.833354999336, 5564.0, 5200.843974680765, 5213.687178769286, 5325.121354976424, 5348.946510534884, 5365.436629153961, 11747.647570572897, 11772.646820595395, 11826.462559867163, 11915.463804128749, 11938.164328497009, 2204.9889750551306, 2232.36377632374, 2389.7610238976135, 2668.2528891910297, 2763.8065335426527, 9981.75228096488, 10174.44040577768, 12441.440135193938, 13628.454861805516, 13897.0, 1842.6867432536367, 1906.094605062598, 1912.4453908366556, 1947.4157752674282, 1973.4770285874256, 77318.22681773223, 79001.0, 79872.0, 81155.18844811476, 81167.0, 9259.907400925904, 9598.9040109598, 9997.600095996078, 10133.277342851732, 10253.897461025443, 12570.371481426075, 13201.47194112244, 13770.65573360674, 13870.237136957565, 13873.791893121612, 5664.122061080539, 5790.507806836466, 6187.84530386744, 7088.468364872655, 7103.502754807114, 6678.833029174212, 6715.764948226886, 6822.147231596051, 6985.860282794316, 7508.3993280537425, 4185.121124563876, 4248.383984322256, 4253.404523366731, 4326.610605045561, 4398.3842262083335, 1729.6108375615638, 1779.4038996935913, 1790.85673146148, 1820.1081470079566, 1867.2437662746609, 997.546116516983, 1039.9496508526443, 1095.7863216672831, 1097.401915955806, 1111.5387114347454, 18584.628307433777, 18698.626027479648, 18733.531661708294, 18868.15093320804, 19317.61364772697, 1034.2966782587762, 1043.4991204222015, 1061.6443491430302, 1073.3774410841693, 1074.6292529077612, 10579.94710026445, 10879.184061195441, 10899.887122519312, 10941.45292735376, 10942.507587158598, 348063.0, 350486.0, 350810.0, 351777.0, 351829.0, 86686.0, 91753.0, 99402.0, 100667.0, 103920.48039759752, 1069.0, 1094.3324572011068, 1099.2580008494235, 1106.1593189176283, 1113.4210210690396, 17112.401065962633, 17259.7411038832, 17265.22306496236, 17498.91250543739, 17538.123093845512, 39993.80003099966, 40293.59706402898, 40623.0, 40671.0, 41064.0, 55918.720406397704, 57263.42736572581, 57792.71103644455, 59011.704941475014, 59111.40888591231, 7750.496217746054, 8120.269175774209, 8192.508449493049, 8406.411551191359, 8424.199701028638, 9196.26429885621, 13150.0, 13518.662033448849, 13624.318784060559, 13730.176189428666, 11657.358845263252, 11760.764784704086, 11962.043036557228, 11979.940100299442, 12025.218360806519, 11487.597934072268, 11645.068394528247, 11667.35829529384, 11764.297164637435, 11902.880971190523, 11129.0, 11674.241174323643, 11930.582429614922, 12265.816012759637, 12456.190347627375, 8056.436049476481, 8258.752237432887, 8308.418410711192, 8350.081491036102, 8350.707725229588, 11002.724931876766, 11871.406429678655, 12001.459934302802, 12346.938265308616, 12488.313142777235], "value": 8676.750251090945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.772784082388, 1543.5986643472697, 1695.7710709054281, 1752.3779058434263, 1817.0642119308566, 7331.9266807331915, 7730.304272615464, 7776.066871975364, 7950.165232650568, 8005.519668819868, 7745.419093567991, 7772.844543109134, 7798.571078590675, 7829.138794732575, 7833.412494062954, 2195.890205489727, 2226.8441209115367, 2230.2751605728204, 2234.497238121418, 2240.5518896220738, 2148.763636000039, 2161.167950339115, 2162.956740865182, 2180.2805074325515, 2185.983517664286, 2195.4182141732454, 2213.4798322394226, 2218.3455880515207, 2224.555088982202, 2237.2617036377956, 2149.355193441969, 2150.1721837092678, 2163.286115581854, 2166.99234855792, 2167.3606286145546, 2102.57948410317, 2103.621348157331, 2111.429913923232, 2118.9617087626953, 2121.3847984084596, 7832.608369581555, 7900.446968712193, 7954.284114429671, 7954.403419743542, 8000.119986801447, 4586.2661974083985, 4756.215224487955, 4766.356541866873, 4768.117898188846, 4779.068081724065, 3213.5822343095247, 3254.0, 3296.884609038696, 3375.9662403375896, 3412.8293585320885, 1168.0, 1171.9569583071072, 1172.8006238939402, 1185.6502331812137, 1194.9820752688718, 11033.337999720043, 11039.83440248397, 11109.277896936674, 11127.888721112766, 11127.888721112848, 4135.379693046007, 4190.308599081118, 4330.870073897788, 4353.238183317907, 4373.212821692063, 9525.428474291564, 9538.141567258841, 9554.522273886418, 9585.808283834423, 9588.712338629852, 4991.625628077909, 4992.475790041994, 5015.996800639887, 5017.147084995559, 5024.171011783088, 4056.290149223874, 4411.316245981878, 4514.0971805639, 4540.523245059221, 4556.248219043887, 3732.0, 3733.757305775116, 3828.8468461261796, 3828.9617103828605, 3831.4061320495366, 1240.503798480597, 1244.7448273103992, 1247.0647014738945, 1248.4007676315239, 1252.3049707412292, 860.6600392844791, 950.4487397309543, 951.9619215231452, 982.1651596143221, 1012.336919317848, 5605.467480589337, 5612.130119831432, 5662.292213473316, 5663.433656634386, 5745.712714364265, 406.2991339938582, 407.12671320018393, 407.57001363561136, 412.42878613120445, 420.4114240063874, 3985.4221137934837, 4070.226656935232, 4070.9389359159636, 4085.632293093636, 4139.523954745183, 9688.12806847387, 9896.950515247378, 10020.048095431068, 10038.548265328078, 10124.69625911224, 9929.404235745878, 9963.302568820112, 10089.495525223709, 10093.697189084192, 10100.545475453622, 7600.961995189989, 7610.0, 7622.58075805825, 7647.847043059108, 7763.029621297225, 5617.073182924772, 5664.819119136905, 5671.376148623565, 5761.91357129635, 5777.873314703593, 8755.387122901591, 8898.0, 9036.0, 9108.453492790453, 9220.815583688423, 8940.15068568485, 8991.730248092306, 9063.184313411824, 9119.361644684808, 9461.952690236505, 6602.966985165043, 7042.50702450844, 7051.6474176292, 7197.316254955771, 7290.453216008715, 7766.495177813424, 7825.060992680915, 7828.765137045898, 7838.490498117832, 7853.45025848208, 6937.89593156093, 7119.181294151239, 7135.714571417293, 7208.315210055036, 7240.927590724025, 6961.199462061928, 7096.290370962863, 7098.680559374944, 7197.46019048563, 7238.493305468567, 6319.652419116993, 6419.711113000019, 6424.839379015562, 6432.324605916311, 6439.774607888701, 5086.7710953007945, 5138.229265610188, 5139.537441630271, 5150.716710580954, 5151.098557752453, 5159.0, 5193.896122077462, 5251.474852514718, 5258.158694608845, 5360.517553420211], "value": 4277.883790230831, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.7750896863227, 323.09855503146224, 323.2645730962062, 333.39655224044463, 334.2145957001048, 5866.2080619116405, 5999.910001349972, 6031.9999999999945, 6069.908951365733, 6107.053406721954, 6047.758089676418, 6048.939510604892, 6052.818415447533, 6070.757169713206, 6080.483158931496, 4610.262358022717, 4616.884577885546, 4617.330487079372, 4619.445666520022, 4635.698679585825, 4270.466191726035, 4499.10017996402, 4509.684322097454, 4533.0, 4622.191116554606, 4439.489458712241, 4442.888927776799, 4464.8883777905485, 4470.217711900421, 4472.195004899117, 4435.379046933415, 4463.509014008457, 4464.6651501137385, 4473.46318441789, 4478.529754375776, 3768.5289338832645, 3843.7501562398634, 3868.4197370394386, 3954.5452272988687, 3963.088489647397, 5750.511206547449, 5755.539556835485, 5762.855928601776, 5782.306123265193, 5802.419758024206, 5248.107821670325, 5276.498732620395, 5290.0, 5291.074062039128, 5301.151815709468, 5939.46544810969, 6218.440340369343, 6263.467605253559, 6266.057522168143, 6318.704665543552, 4303.978480107579, 4342.50061242958, 4344.044310251739, 4344.804483798237, 4346.15250026245, 6197.194364732556, 6512.609243445361, 6515.7067931943175, 6569.704363303663, 6591.143151390289, 4219.472565929259, 4231.978840105779, 4237.957620423818, 4244.745315281031, 4267.679924005712, 4250.702450828474, 4273.764942928106, 4292.0, 4294.785260737013, 4295.699301048897, 5076.035553244872, 5123.872747995435, 5131.409887862869, 5131.409887862944, 5140.922886156711, 6163.445289923929, 6268.216472940882, 6381.872362552723, 6385.201849768779, 6404.807855764335, 1598.9200539972956, 1607.2044338052506, 1615.7414813629762, 1617.5147455763224, 1618.2070785315111, 1025.6564051042835, 1041.8280983637615, 1046.1735229168871, 1051.295631926611, 1056.5245639462273, 6094.786682466092, 6111.96944015277, 6115.143879856823, 6122.173506576644, 6134.8159555213415, 6505.544611877123, 6528.477721782246, 6545.639989800511, 6562.475001999828, 6568.507361947873, 5907.645541267538, 6035.818925432244, 6052.6671033092725, 6081.543884208702, 6082.118092876508, 3497.8600855965983, 3506.386382383124, 3512.841922113511, 3527.9294414111573, 3546.6453354664327, 6605.86788264232, 6729.663516824139, 6744.494162937701, 6773.221079575912, 6787.626680532618, 6686.7993960181275, 6691.966540167366, 6715.608617648057, 6730.360615741497, 6732.004258105097, 6643.833904152339, 6651.63416012124, 6743.797686069426, 6776.273049822578, 6787.1176747023555, 6487.448566871869, 6488.351164883474, 6512.218533775977, 6517.250516190698, 6539.7384104637185, 6290.591111577733, 6309.432151106423, 6447.484201263981, 6448.484121270193, 6475.838104047248, 6665.866682666417, 6682.0, 6723.798286051427, 6731.562448440835, 6735.49483788708, 4452.354408610798, 4465.151621191963, 4478.731276123443, 4484.798184081659, 4491.270860718712, 6243.157173781663, 6412.711427985659, 6506.41442270198, 6626.171728533934, 6630.668466576748, 6388.744450222125, 6427.132337134614, 6431.871362572816, 6457.3865482779065, 6464.5798023128345, 6241.375862413723, 6348.174737284124, 6382.489400847828, 6435.4529864962005, 6461.224653041665, 6267.4045965633195, 6276.152719382825, 6285.277193122849, 6294.24469063697, 6322.430981211713, 6400.167978162809, 6447.838804029937, 6459.935400645933, 6477.51418643613, 6480.319566445644, 6163.0, 6176.505879529537, 6311.779087731908, 6317.4630156437215, 6342.207224096988], "value": 4743.097084044068, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.204827221051, 810.1210186947162, 843.8438888805572, 848.8047749017726, 859.5831021954347, 12749.681257968556, 14027.0, 14085.718285634293, 14096.365663545139, 14116.647083822909, 13165.80251296229, 13179.077464577484, 13228.206307621549, 13237.933810330935, 13295.734085318289, 690.5373399822131, 798.1579433697447, 815.9428839981189, 826.3348004856089, 838.3000194837318, 829.7510746775973, 834.0658462521953, 834.8539005673982, 837.4054421360842, 840.231188462556, 861.2464093917822, 863.201538576817, 865.8960924689046, 868.3704314372093, 871.6687658689689, 856.4818284937617, 856.5631527920774, 864.2610567964425, 864.5331520978664, 868.079835374505, 631.8578319878037, 632.3202557250928, 634.5241069198102, 635.5233574818886, 636.4494712074069, 13053.216806991612, 13058.412371443308, 13063.0, 13087.345632718327, 13096.934515327363, 13488.325583720774, 13545.187288762607, 13568.1859088455, 13623.863761362358, 13657.453701852013, 11937.701557461047, 12134.696632584257, 12316.261024338479, 12446.190997585129, 12657.620271391874, 4545.795439205211, 4564.703294285894, 4575.565321294472, 4639.837605683785, 4682.672212945095, 53313.733431332985, 53668.0, 55731.16403253954, 55793.72103139499, 56116.719416403066, 10284.588616455258, 10389.272750907365, 10530.736731581772, 10557.102646275152, 10774.138068954464, 18109.909450452928, 18234.908825455786, 18247.0, 18273.0, 18327.54181145482, 8077.151899050633, 8087.555184464911, 8140.145284745135, 8220.547869867096, 8279.047909490366, 4391.429114215131, 4397.538258482878, 4411.051623900877, 4522.841700540531, 4608.5621865922685, 3042.771792115556, 3126.937461250762, 3135.106494649014, 3135.5139953307275, 3146.8111913285275, 586.0535235594484, 588.885167392363, 594.0910407077179, 600.0788789208544, 608.9878202435926, 605.8909396308707, 639.3925770517933, 639.667372966055, 762.4091329219788, 767.5202998126172, 8457.112003239572, 8505.234528892306, 8629.61166747498, 8906.287497000225, 9118.179363857285, 549.1433363952248, 625.515225700086, 670.2058061197497, 676.9153855768029, 680.5678394219706, 3827.8086095695103, 4097.836086556564, 4194.601512856274, 4219.894502637398, 4241.660667146621, 50823.0, 55088.72455637696, 55700.0, 55859.72070139705, 62094.37905620886, 48340.5165948336, 51219.0, 52345.7382713084, 53019.46980530145, 54509.0, 46956.5304346959, 47059.764701176275, 47603.0, 48459.0, 49263.75368123136, 8446.324294056338, 8514.61684224199, 8560.272376848037, 8786.341024423322, 8801.427907186013, 23887.64168537508, 24709.50580988406, 24840.875795620905, 28044.579331310455, 32031.519527207576, 45584.316235255836, 45911.54088459073, 46264.768676156404, 46501.0, 46568.53431465642, 10881.07510861554, 10882.40146791934, 11002.229843910849, 11032.503537340679, 11088.16838737114, 11577.826332604849, 11582.594609188638, 11901.76196476083, 11940.10449216295, 12682.302473363685, 11543.19197656156, 12047.939760301142, 12087.274763514217, 12105.576304829288, 12131.272123672255, 11656.766864662828, 11659.30044197317, 12052.216605920587, 12458.377081146087, 12466.563670271496, 12204.511819527119, 12259.448324825225, 12312.445939932546, 12452.937735311265, 12929.54746583865, 9821.0, 9930.801383972424, 10026.197904167795, 10040.69877903664, 10118.544665490217, 10028.449147771023, 10029.648962286285, 10176.694699159038, 10362.430066346424, 10570.947145264225], "value": 6508.05731573371, "unit": "score"}], "name": "dromaeo_css", "value": 6924.332518804159, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 112.0, 111.0, 112.0, 123.0, 112.0, 112.0, 112.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 127.0, 151.0, 182.0, 133.0, 150.0, 154.0, 130.0, 190.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 164.0, 163.0, 173.0, 162.0, 166.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 158.0, 74.0, 74.0, 77.0, 74.0, 172.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 152.0, 93.0, 93.0, 93.0, 147.0, 94.0, 93.0, 148.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 58.0, 58.0, 57.0, 58.0, 58.0, 78.0, 59.0, 54.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 76.0, 76.0, 86.0, 76.0, 77.0, 77.0, 78.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 129.0, 129.0, 134.0, 142.0, 129.0, 125.0, 126.0, 162.0, 126.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 168.0, 162.0, 163.0, 174.0, 165.0, 169.0, 161.0, 166.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 71.0, 67.0, 66.0, 70.0, 67.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1562.3, "alertThreshold": 2.0}]} 05:23:27 INFO - Return code: 0 05:23:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:23:27 ERROR - # TBPL SUCCESS # 05:23:27 INFO - Running post-action listener: _resource_record_post_action 05:23:27 INFO - Running post-run listener: _resource_record_post_run 05:23:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 45056; Write bytes: 536092672; Read time: 56; Write time: 582008 05:23:28 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244420608; Read time: 0; Write time: 326844 05:23:28 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 45056; Write bytes: 291672064; Read time: 56; Write time: 255164 05:23:28 INFO - Running post-run listener: _upload_blobber_files 05:23:28 INFO - Blob upload gear active. 05:23:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:23:28 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'] 05:23:28 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 05:23:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:23:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:23:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:30 INFO - (blobuploader) - INFO - Done attempting. 05:23:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:23:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:23:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:31 INFO - (blobuploader) - INFO - Done attempting. 05:23:31 INFO - (blobuploader) - INFO - Iteration through files over. 05:23:31 INFO - Return code: 0 05:23:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:23:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:23:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58aac70ee970ee1c089ab5128b60c466cca42657bfbbb60da5155e7556b7ea192fc0198082faac9efd46d5629e61e052b890a44fdb68d52dfe003f295be7f2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fca0b84ad522a3988d69bae77375cb2c3ba8f877822e067f53fc6718a64dad0cfaec2c76541164670d092b57f4f43bb1403a51dba5d247884f7c070888edb0e5"} 05:23:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:23:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:23:31 INFO - Contents: 05:23:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58aac70ee970ee1c089ab5128b60c466cca42657bfbbb60da5155e7556b7ea192fc0198082faac9efd46d5629e61e052b890a44fdb68d52dfe003f295be7f2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fca0b84ad522a3988d69bae77375cb2c3ba8f877822e067f53fc6718a64dad0cfaec2c76541164670d092b57f4f43bb1403a51dba5d247884f7c070888edb0e5"} 05:23:31 INFO - Running post-run listener: copy_logs_to_upload_dir 05:23:31 INFO - Copying logs to upload dir... 05:23:31 INFO - mkdir: /builds/slave/test/build/upload/logs 05:23:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.266048 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-20 05:23:31.320696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 05:23:31.327523) ========= 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=836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965 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/58aac70ee970ee1c089ab5128b60c466cca42657bfbbb60da5155e7556b7ea192fc0198082faac9efd46d5629e61e052b890a44fdb68d52dfe003f295be7f2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fca0b84ad522a3988d69bae77375cb2c3ba8f877822e067f53fc6718a64dad0cfaec2c76541164670d092b57f4f43bb1403a51dba5d247884f7c070888edb0e5"} build_url:https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/W1MEUkwiTjyYRuUj2MjxdQ/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/58aac70ee970ee1c089ab5128b60c466cca42657bfbbb60da5155e7556b7ea192fc0198082faac9efd46d5629e61e052b890a44fdb68d52dfe003f295be7f2a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fca0b84ad522a3988d69bae77375cb2c3ba8f877822e067f53fc6718a64dad0cfaec2c76541164670d092b57f4f43bb1403a51dba5d247884f7c070888edb0e5"}' ========= master_lag: 0.23 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 05:23:31.566443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:23:31.566828) ========= 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=836cfdc75598d54cb747368e000001a9-1461153767.654209-1732248965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:23:31.584723) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 05:23:31.588090) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 05:23:31.588458) ========= ========= Total master_lag: 0.52 =========