builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1461358682.72 results: success (0) buildid: 20160422131145 builduid: 87190c818e864d288903c10b07af8d60 revision: ab85f19b67b1d093e060bfe52a672a3a9995e252 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.715631) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.716063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.716375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.732924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.733239) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-22 13:58:03-- 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% 224M=0s 2016-04-22 13:58:03 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.840381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.840746) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014901 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.890054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:02.890366) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab85f19b67b1d093e060bfe52a672a3a9995e252 --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 ab85f19b67b1d093e060bfe52a672a3a9995e252 --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=8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-22 13:58:03,382 truncating revision to first 12 chars 2016-04-22 13:58:03,382 Setting DEBUG logging. 2016-04-22 13:58:03,382 attempt 1/10 2016-04-22 13:58:03,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab85f19b67b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 13:58:03,850 unpacking tar archive at: fx-team-ab85f19b67b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752915 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:03.655755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:03.656101) ========= script_repo_revision: ab85f19b67b1d093e060bfe52a672a3a9995e252 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:03.656496) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:03.656782) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 13:58:03.665701) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-22 13:58:03.665971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:58:04 INFO - MultiFileLogger online at 20160422 13:58:04 in /builds/slave/test 13:58:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:58:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:58:04 INFO - {'append_to_log': False, 13:58:04 INFO - 'base_work_dir': '/builds/slave/test', 13:58:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:58:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:58:04 INFO - 'branch': 'Fx-Team-Non-PGO', 13:58:04 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:04 INFO - 'config_files': ('talos/linux_config.py',), 13:58:04 INFO - 'default_actions': ('clobber', 13:58:04 INFO - 'read-buildbot-config', 13:58:04 INFO - 'download-and-extract', 13:58:04 INFO - 'populate-webroot', 13:58:04 INFO - 'create-virtualenv', 13:58:04 INFO - 'install', 13:58:04 INFO - 'run-tests'), 13:58:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:04 INFO - 'download_minidump_stackwalk': True, 13:58:04 INFO - 'download_symbols': 'ondemand', 13:58:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:04 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:04 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:04 INFO - 'installer_path': 'installer.exe', 13:58:04 INFO - 'log_level': 'info', 13:58:04 INFO - 'log_name': 'talos', 13:58:04 INFO - 'log_to_console': True, 13:58:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:58:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:58:04 INFO - 'opt_config_files': (), 13:58:04 INFO - 'pip_index': False, 13:58:04 INFO - 'sps_profile': False, 13:58:04 INFO - 'sps_profile_interval': 0, 13:58:04 INFO - 'suite': 'dromaeojs', 13:58:04 INFO - 'system_bits': '32', 13:58:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:04 INFO - 'title': 'talos-linux64-ix-049', 13:58:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:04 INFO - 'use_talos_json': True, 13:58:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:58:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:04 INFO - 'work_dir': 'build'} 13:58:04 INFO - ##### 13:58:04 INFO - ##### Running clobber step. 13:58:04 INFO - ##### 13:58:04 INFO - Running pre-action listener: _resource_record_pre_action 13:58:04 INFO - Running main action method: clobber 13:58:04 INFO - rmtree: /builds/slave/test/build 13:58:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:58:04 INFO - Running post-action listener: _resource_record_post_action 13:58:04 INFO - ##### 13:58:04 INFO - ##### Running read-buildbot-config step. 13:58:04 INFO - ##### 13:58:04 INFO - Running pre-action listener: _resource_record_pre_action 13:58:04 INFO - Running main action method: read_buildbot_config 13:58:04 INFO - Using buildbot properties: 13:58:04 INFO - { 13:58:04 INFO - "project": "", 13:58:04 INFO - "product": "firefox", 13:58:04 INFO - "script_repo_revision": "production", 13:58:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:58:04 INFO - "repository": "", 13:58:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:58:04 INFO - "buildid": "20160422131145", 13:58:04 INFO - "pgo_build": "False", 13:58:04 INFO - "basedir": "/builds/slave/test", 13:58:04 INFO - "buildnumber": 2868, 13:58:04 INFO - "slavename": "talos-linux64-ix-049", 13:58:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:58:04 INFO - "platform": "ubuntu64_hw", 13:58:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:58:04 INFO - "branch": "fx-team", 13:58:04 INFO - "repo_path": "integration/fx-team", 13:58:04 INFO - "revision": "ab85f19b67b1d093e060bfe52a672a3a9995e252", 13:58:04 INFO - "stage_platform": "linux64", 13:58:04 INFO - "builduid": "87190c818e864d288903c10b07af8d60", 13:58:04 INFO - "slavebuilddir": "test" 13:58:04 INFO - } 13:58:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:58:04 INFO - Running post-action listener: _resource_record_post_action 13:58:04 INFO - ##### 13:58:04 INFO - ##### Running download-and-extract step. 13:58:04 INFO - ##### 13:58:04 INFO - Running pre-action listener: _resource_record_pre_action 13:58:04 INFO - Running main action method: download_and_extract 13:58:04 INFO - mkdir: /builds/slave/test/build/tests 13:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:04 INFO - https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:58:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:58:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:58:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:06 INFO - Downloaded 1361 bytes. 13:58:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:58:06 INFO - Using the following test package requirements: 13:58:06 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:58:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:58:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'jsshell-linux-x86_64.zip'], 13:58:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:58:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:58:06 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:58:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:58:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:58:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:06 INFO - https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:58:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:58:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:11 INFO - Downloaded 22285608 bytes. 13:58:11 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'] 13:58:11 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 13:58:13 INFO - Return code: 0 13:58:13 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 13:58:13 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')]} 13:58:13 INFO - https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:58:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:58:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:58:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:16 INFO - Downloaded 22285608 bytes. 13:58:16 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'] 13:58:16 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 13:58:17 INFO - Return code: 0 13:58: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')]} 13:58:17 INFO - https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:58:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:18 INFO - Downloaded 10840145 bytes. 13:58:18 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'] 13:58:18 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 13:58:18 INFO - Return code: 0 13:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:18 INFO - https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:58:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:58:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:58:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/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 13:58:20 INFO - Downloaded 54743368 bytes. 13:58:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:58:20 INFO - mkdir: /builds/slave/test/properties 13:58:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:58:20 INFO - Writing to file /builds/slave/test/properties/build_url 13:58:20 INFO - Contents: 13:58:20 INFO - build_url:https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:58:21 INFO - Running post-action listener: _resource_record_post_action 13:58:21 INFO - Running post-action listener: set_extra_try_arguments 13:58:21 INFO - ##### 13:58:21 INFO - ##### Running populate-webroot step. 13:58:21 INFO - ##### 13:58:21 INFO - Running pre-action listener: _resource_record_pre_action 13:58:21 INFO - Running main action method: populate_webroot 13:58:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:21 INFO - '--tppagecycles', 13:58:21 INFO - '7'], 13:58:21 INFO - 'tests': ['tsvgm']}}, 13:58:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:58:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:58:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:58:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['damp', 'tps']}, 13:58:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'tests': ['damp', 'tps']}, 13:58:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['dromaeo_dom']}, 13:58:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['a11yr', 13:58:21 INFO - 'ts_paint', 13:58:21 INFO - 'tpaint', 13:58:21 INFO - 'sessionrestore', 13:58:21 INFO - 'sessionrestore_no_auto_restore', 13:58:21 INFO - 'tabpaint']}, 13:58:21 INFO - 'other-e10s': {'tests': ['a11yr', 13:58:21 INFO - 'ts_paint', 13:58:21 INFO - 'tpaint', 13:58:21 INFO - 'sessionrestore', 13:58:21 INFO - 'sessionrestore_no_auto_restore', 13:58:21 INFO - 'tabpaint']}, 13:58:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:58:21 INFO - 'ts_paint', 13:58:21 INFO - 'tpaint', 13:58:21 INFO - 'sessionrestore', 13:58:21 INFO - 'sessionrestore_no_auto_restore', 13:58:21 INFO - 'tabpaint']}, 13:58:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:58:21 INFO - 'ts_paint', 13:58:21 INFO - 'tpaint', 13:58:21 INFO - 'sessionrestore', 13:58:21 INFO - 'sessionrestore_no_auto_restore', 13:58:21 INFO - 'tabpaint']}, 13:58:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['a11yr', 13:58:21 INFO - 'ts_paint', 13:58:21 INFO - 'tpaint', 13:58:21 INFO - 'sessionrestore', 13:58:21 INFO - 'sessionrestore_no_auto_restore', 13:58:21 INFO - 'tabpaint']}, 13:58:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['a11yr', 13:58:21 INFO - 'ts_paint', 13:58:21 INFO - 'tpaint', 13:58:21 INFO - 'sessionrestore', 13:58:21 INFO - 'sessionrestore_no_auto_restore', 13:58:21 INFO - 'tabpaint']}, 13:58:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['tsvgx', 13:58:21 INFO - 'tsvgr_opacity', 13:58:21 INFO - 'tart', 13:58:21 INFO - 'tscrollx', 13:58:21 INFO - 'cart']}, 13:58:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:58:21 INFO - 'tsvgr_opacity', 13:58:21 INFO - 'tart', 13:58:21 INFO - 'tscrollx', 13:58:21 INFO - 'cart']}, 13:58:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'talos_options': ['--disable-e10s'], 13:58:21 INFO - 'tests': ['tp5o']}, 13:58:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'tests': ['tp5o']}, 13:58:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'talos_options': ['--disable-e10s', 13:58:21 INFO - '--xperf_path', 13:58:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:21 INFO - 'tests': ['tp5n']}, 13:58:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:58:21 INFO - 'talos_options': ['--xperf_path', 13:58:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:21 INFO - 'tests': ['tp5n']}}, 13:58:21 INFO - 'talos.zip': {'path': '', 13:58:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:21 INFO - Running post-action listener: _resource_record_post_action 13:58:21 INFO - ##### 13:58:21 INFO - ##### Running create-virtualenv step. 13:58:21 INFO - ##### 13:58:21 INFO - Running pre-action listener: _resource_record_pre_action 13:58:21 INFO - Running main action method: create_virtualenv 13:58:21 INFO - Creating virtualenv /builds/slave/test/build/venv 13:58:21 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 13:58:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:58:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:21 INFO - Using real prefix '/usr' 13:58:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:58:22 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:24 INFO - Installing pip.................done. 13:58:24 INFO - Return code: 0 13:58:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:58:24 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')]} 13:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:24 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')]} 13:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:24 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:24 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 13:58:24 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 13:58:24 INFO - Using env: {'DISPLAY': ':0', 13:58:24 INFO - 'HOME': '/home/cltbld', 13:58:24 INFO - 'LANG': 'en_US.UTF-8', 13:58:24 INFO - 'LANGUAGE': 'en_US:en', 13:58:24 INFO - 'LOGNAME': 'cltbld', 13:58:24 INFO - 'MAIL': '/var/mail/cltbld', 13:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:24 INFO - 'MOZ_NO_REMOTE': '1', 13:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:24 INFO - 'NO_EM_RESTART': '1', 13:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:24 INFO - 'PWD': '/builds/slave/test', 13:58:24 INFO - 'SHELL': '/bin/bash', 13:58:24 INFO - 'SHLVL': '1', 13:58:24 INFO - 'TERM': 'linux', 13:58:24 INFO - 'TMOUT': '86400', 13:58:24 INFO - 'USER': 'cltbld', 13:58:24 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:24 INFO - '_': '/tools/buildbot/bin/python'} 13:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:24 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 13:58:24 INFO - Cleaning up... 13:58:24 INFO - Return code: 0 13:58:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:58:24 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')]} 13:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:24 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')]} 13:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:24 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:24 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 13:58:24 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 13:58:24 INFO - Using env: {'DISPLAY': ':0', 13:58:24 INFO - 'HOME': '/home/cltbld', 13:58:24 INFO - 'LANG': 'en_US.UTF-8', 13:58:24 INFO - 'LANGUAGE': 'en_US:en', 13:58:24 INFO - 'LOGNAME': 'cltbld', 13:58:24 INFO - 'MAIL': '/var/mail/cltbld', 13:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:24 INFO - 'MOZ_NO_REMOTE': '1', 13:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:24 INFO - 'NO_EM_RESTART': '1', 13:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:24 INFO - 'PWD': '/builds/slave/test', 13:58:24 INFO - 'SHELL': '/bin/bash', 13:58:24 INFO - 'SHLVL': '1', 13:58:24 INFO - 'TERM': 'linux', 13:58:24 INFO - 'TMOUT': '86400', 13:58:24 INFO - 'USER': 'cltbld', 13:58:24 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:24 INFO - '_': '/tools/buildbot/bin/python'} 13:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:24 INFO - Downloading/unpacking psutil>=0.7.1 13:58:24 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 13:58:24 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 13:58:24 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 13:58:24 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 13:58:24 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 13:58:24 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 13:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:58:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:26 INFO - Installing collected packages: psutil 13:58:26 INFO - Running setup.py install for psutil 13:58:26 INFO - building 'psutil._psutil_linux' extension 13:58:26 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 13:58:26 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 13:58:26 INFO - building 'psutil._psutil_posix' extension 13:58:26 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 13:58:27 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 13:58:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:27 INFO - Successfully installed psutil 13:58:27 INFO - Cleaning up... 13:58:27 INFO - Return code: 0 13:58:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:27 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:27 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 13:58:27 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 13:58:27 INFO - Using env: {'DISPLAY': ':0', 13:58:27 INFO - 'HOME': '/home/cltbld', 13:58:27 INFO - 'LANG': 'en_US.UTF-8', 13:58:27 INFO - 'LANGUAGE': 'en_US:en', 13:58:27 INFO - 'LOGNAME': 'cltbld', 13:58:27 INFO - 'MAIL': '/var/mail/cltbld', 13:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:27 INFO - 'MOZ_NO_REMOTE': '1', 13:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:27 INFO - 'NO_EM_RESTART': '1', 13:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:27 INFO - 'PWD': '/builds/slave/test', 13:58:27 INFO - 'SHELL': '/bin/bash', 13:58:27 INFO - 'SHLVL': '1', 13:58:27 INFO - 'TERM': 'linux', 13:58:27 INFO - 'TMOUT': '86400', 13:58:27 INFO - 'USER': 'cltbld', 13:58:27 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:27 INFO - '_': '/tools/buildbot/bin/python'} 13:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:58:29 INFO - Installing collected packages: mozsystemmonitor 13:58:29 INFO - Running setup.py install for mozsystemmonitor 13:58:29 INFO - Successfully installed mozsystemmonitor 13:58:29 INFO - Cleaning up... 13:58:29 INFO - Return code: 0 13:58:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:29 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 13:58:29 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 13:58:29 INFO - Using env: {'DISPLAY': ':0', 13:58:29 INFO - 'HOME': '/home/cltbld', 13:58:29 INFO - 'LANG': 'en_US.UTF-8', 13:58:29 INFO - 'LANGUAGE': 'en_US:en', 13:58:29 INFO - 'LOGNAME': 'cltbld', 13:58:29 INFO - 'MAIL': '/var/mail/cltbld', 13:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:29 INFO - 'MOZ_NO_REMOTE': '1', 13:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:29 INFO - 'NO_EM_RESTART': '1', 13:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:29 INFO - 'PWD': '/builds/slave/test', 13:58:29 INFO - 'SHELL': '/bin/bash', 13:58:29 INFO - 'SHLVL': '1', 13:58:29 INFO - 'TERM': 'linux', 13:58:29 INFO - 'TMOUT': '86400', 13:58:29 INFO - 'USER': 'cltbld', 13:58:29 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:29 INFO - '_': '/tools/buildbot/bin/python'} 13:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:29 INFO - Downloading/unpacking blobuploader==1.2.4 13:58:29 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 13:58:29 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 13:58:29 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 13:58:29 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 13:58:29 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 13:58:29 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 13:58:31 INFO - Downloading blobuploader-1.2.4.tar.gz 13:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:58:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:58:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58:32 INFO - Downloading docopt-0.6.1.tar.gz 13:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:58:32 INFO - Installing collected packages: blobuploader, requests, docopt 13:58:32 INFO - Running setup.py install for blobuploader 13:58:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:58:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:58:32 INFO - Running setup.py install for requests 13:58:32 INFO - Running setup.py install for docopt 13:58:32 INFO - Successfully installed blobuploader requests docopt 13:58:32 INFO - Cleaning up... 13:58:32 INFO - Return code: 0 13:58:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:32 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:32 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 13:58:32 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 13:58:32 INFO - Using env: {'DISPLAY': ':0', 13:58:32 INFO - 'HOME': '/home/cltbld', 13:58:32 INFO - 'LANG': 'en_US.UTF-8', 13:58:32 INFO - 'LANGUAGE': 'en_US:en', 13:58:32 INFO - 'LOGNAME': 'cltbld', 13:58:32 INFO - 'MAIL': '/var/mail/cltbld', 13:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:32 INFO - 'MOZ_NO_REMOTE': '1', 13:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:32 INFO - 'NO_EM_RESTART': '1', 13:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:32 INFO - 'PWD': '/builds/slave/test', 13:58:32 INFO - 'SHELL': '/bin/bash', 13:58:32 INFO - 'SHLVL': '1', 13:58:32 INFO - 'TERM': 'linux', 13:58:32 INFO - 'TMOUT': '86400', 13:58:32 INFO - 'USER': 'cltbld', 13:58:32 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:32 INFO - '_': '/tools/buildbot/bin/python'} 13:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:33 INFO - Running setup.py (path:/tmp/pip-O3ekVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:33 INFO - Running setup.py (path:/tmp/pip-ZzOL1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:33 INFO - Running setup.py (path:/tmp/pip-efqlBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:33 INFO - Running setup.py (path:/tmp/pip-5qgxDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:33 INFO - Running setup.py (path:/tmp/pip-_FnJqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:33 INFO - Running setup.py (path:/tmp/pip-LOuycE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:33 INFO - Running setup.py (path:/tmp/pip-EDDj9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:33 INFO - Running setup.py (path:/tmp/pip-SZtMiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:33 INFO - Running setup.py (path:/tmp/pip-8o3Mm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:33 INFO - Running setup.py (path:/tmp/pip-CJzcXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:33 INFO - Running setup.py (path:/tmp/pip-rAq7H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:33 INFO - Running setup.py (path:/tmp/pip-2deY7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:33 INFO - Running setup.py (path:/tmp/pip-gfoZqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:34 INFO - Running setup.py (path:/tmp/pip-U1GAyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:34 INFO - Running setup.py (path:/tmp/pip-rXJdm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:34 INFO - Running setup.py (path:/tmp/pip-zX_8TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:34 INFO - Running setup.py (path:/tmp/pip-an7Mlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:34 INFO - Running setup.py install for manifestparser 13:58:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:58:34 INFO - Running setup.py install for mozcrash 13:58:34 INFO - Running setup.py install for mozdebug 13:58:34 INFO - Running setup.py install for mozdevice 13:58:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:58:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:58:34 INFO - Running setup.py install for mozfile 13:58:34 INFO - Running setup.py install for mozhttpd 13:58:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:58:34 INFO - Running setup.py install for mozinfo 13:58:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:58:34 INFO - Running setup.py install for mozInstall 13:58:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Running setup.py install for mozleak 13:58:35 INFO - Running setup.py install for mozlog 13:58:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Running setup.py install for moznetwork 13:58:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Running setup.py install for mozprocess 13:58:35 INFO - Running setup.py install for mozprofile 13:58:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Running setup.py install for mozrunner 13:58:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:58:35 INFO - Running setup.py install for mozscreenshot 13:58:35 INFO - Running setup.py install for moztest 13:58:35 INFO - Running setup.py install for mozversion 13:58:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:58:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:36 INFO - Cleaning up... 13:58:36 INFO - Return code: 0 13:58:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:36 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:36 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 13:58:36 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 13:58:36 INFO - Using env: {'DISPLAY': ':0', 13:58:36 INFO - 'HOME': '/home/cltbld', 13:58:36 INFO - 'LANG': 'en_US.UTF-8', 13:58:36 INFO - 'LANGUAGE': 'en_US:en', 13:58:36 INFO - 'LOGNAME': 'cltbld', 13:58:36 INFO - 'MAIL': '/var/mail/cltbld', 13:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:36 INFO - 'MOZ_NO_REMOTE': '1', 13:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:36 INFO - 'NO_EM_RESTART': '1', 13:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:36 INFO - 'PWD': '/builds/slave/test', 13:58:36 INFO - 'SHELL': '/bin/bash', 13:58:36 INFO - 'SHLVL': '1', 13:58:36 INFO - 'TERM': 'linux', 13:58:36 INFO - 'TMOUT': '86400', 13:58:36 INFO - 'USER': 'cltbld', 13:58:36 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:36 INFO - '_': '/tools/buildbot/bin/python'} 13:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:36 INFO - Running setup.py (path:/tmp/pip-EHMOlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:36 INFO - Running setup.py (path:/tmp/pip-PDo_Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:36 INFO - Running setup.py (path:/tmp/pip-qGsGJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:36 INFO - Running setup.py (path:/tmp/pip-ScW0G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:36 INFO - Running setup.py (path:/tmp/pip-0sKEdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:36 INFO - Running setup.py (path:/tmp/pip-FqWNTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:36 INFO - Running setup.py (path:/tmp/pip-n3Dklf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:36 INFO - Running setup.py (path:/tmp/pip-N_nUea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:36 INFO - Running setup.py (path:/tmp/pip-gTn4pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:36 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)) 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:36 INFO - Running setup.py (path:/tmp/pip-GOdQuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:37 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)) 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:37 INFO - Running setup.py (path:/tmp/pip-rrOEgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:37 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)) 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:37 INFO - Running setup.py (path:/tmp/pip-dqmZd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:37 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)) 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:37 INFO - Running setup.py (path:/tmp/pip-VvXlzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:37 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)) 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:37 INFO - Running setup.py (path:/tmp/pip-sUlKf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:37 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)) 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:37 INFO - Running setup.py (path:/tmp/pip-FXd74Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:37 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)) 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:37 INFO - Running setup.py (path:/tmp/pip-1Oujmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:37 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)) 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:37 INFO - Running setup.py (path:/tmp/pip-BXEX7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:37 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)) 13:58:37 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)) 13:58:37 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)) 13:58:37 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)) 13:58:37 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)) 13:58:37 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)) 13:58:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:37 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 13:58:37 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 13:58:37 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 13:58:37 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 13:58:37 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 13:58:37 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 13:58:39 INFO - Downloading blessings-1.6.tar.gz 13:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:39 INFO - Installing collected packages: blessings 13:58:39 INFO - Running setup.py install for blessings 13:58:39 INFO - Successfully installed blessings 13:58:39 INFO - Cleaning up... 13:58:39 INFO - Return code: 0 13:58:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:39 INFO - Reading from file tmpfile_stdout 13:58:39 INFO - Current package versions: 13:58:39 INFO - argparse == 1.2.1 13:58:39 INFO - blessings == 1.6 13:58:39 INFO - blobuploader == 1.2.4 13:58:39 INFO - docopt == 0.6.1 13:58:39 INFO - manifestparser == 1.1 13:58:39 INFO - mozInstall == 1.12 13:58:39 INFO - mozcrash == 0.17 13:58:39 INFO - mozdebug == 0.1 13:58:39 INFO - mozdevice == 0.48 13:58:39 INFO - mozfile == 1.2 13:58:39 INFO - mozhttpd == 0.7 13:58:39 INFO - mozinfo == 0.9 13:58:39 INFO - mozleak == 0.1 13:58:39 INFO - mozlog == 3.1 13:58:39 INFO - moznetwork == 0.27 13:58:39 INFO - mozprocess == 0.22 13:58:39 INFO - mozprofile == 0.28 13:58:39 INFO - mozrunner == 6.11 13:58:39 INFO - mozscreenshot == 0.1 13:58:39 INFO - mozsystemmonitor == 0.0 13:58:39 INFO - moztest == 0.7 13:58:39 INFO - mozversion == 1.4 13:58:39 INFO - psutil == 3.1.1 13:58:39 INFO - requests == 1.2.3 13:58:39 INFO - wsgiref == 0.1.2 13:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:39 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:39 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 13:58:39 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 13:58:39 INFO - Using env: {'DISPLAY': ':0', 13:58:39 INFO - 'HOME': '/home/cltbld', 13:58:39 INFO - 'LANG': 'en_US.UTF-8', 13:58:39 INFO - 'LANGUAGE': 'en_US:en', 13:58:39 INFO - 'LOGNAME': 'cltbld', 13:58:39 INFO - 'MAIL': '/var/mail/cltbld', 13:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:39 INFO - 'MOZ_NO_REMOTE': '1', 13:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:39 INFO - 'NO_EM_RESTART': '1', 13:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:39 INFO - 'PWD': '/builds/slave/test', 13:58:39 INFO - 'SHELL': '/bin/bash', 13:58:39 INFO - 'SHLVL': '1', 13:58:39 INFO - 'TERM': 'linux', 13:58:39 INFO - 'TMOUT': '86400', 13:58:39 INFO - 'USER': 'cltbld', 13:58:39 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:39 INFO - '_': '/tools/buildbot/bin/python'} 13:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 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)) 13:58:40 INFO - Cleaning up... 13:58:40 INFO - Return code: 0 13:58:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:58:40 INFO - Using env: {'DISPLAY': ':0', 13:58:40 INFO - 'HOME': '/home/cltbld', 13:58:40 INFO - 'LANG': 'en_US.UTF-8', 13:58:40 INFO - 'LANGUAGE': 'en_US:en', 13:58:40 INFO - 'LOGNAME': 'cltbld', 13:58:40 INFO - 'MAIL': '/var/mail/cltbld', 13:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:40 INFO - 'MOZ_NO_REMOTE': '1', 13:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:40 INFO - 'NO_EM_RESTART': '1', 13:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:40 INFO - 'PWD': '/builds/slave/test', 13:58:40 INFO - 'SHELL': '/bin/bash', 13:58:40 INFO - 'SHLVL': '1', 13:58:40 INFO - 'TERM': 'linux', 13:58:40 INFO - 'TMOUT': '86400', 13:58:40 INFO - 'USER': 'cltbld', 13:58:40 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:40 INFO - '_': '/tools/buildbot/bin/python'} 13:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:40 INFO - Downloading/unpacking jsonschema 13:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:58:42 INFO - Downloading/unpacking functools32 (from jsonschema) 13:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:42 INFO - Downloading functools32-3.2.3-2.tar.gz 13:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:58:42 INFO - warning: no files found matching '*.txt' 13:58:42 INFO - no previously-included directories found matching 'build' 13:58:42 INFO - no previously-included directories found matching 'dist' 13:58:42 INFO - no previously-included directories found matching '.git*' 13:58:42 INFO - Installing collected packages: jsonschema, functools32 13:58:42 INFO - Running setup.py install for functools32 13:58:42 INFO - warning: no files found matching '*.txt' 13:58:42 INFO - no previously-included directories found matching 'build' 13:58:42 INFO - no previously-included directories found matching 'dist' 13:58:42 INFO - no previously-included directories found matching '.git*' 13:58:42 INFO - Successfully installed jsonschema functools32 13:58:42 INFO - Cleaning up... 13:58:42 INFO - Return code: 0 13:58:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:58:42 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')]} 13:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:42 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')]} 13:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:42 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 0x7f5c6ddb0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', '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 13:58:42 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 13:58:42 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 13:58:42 INFO - Using env: {'DISPLAY': ':0', 13:58:42 INFO - 'HOME': '/home/cltbld', 13:58:42 INFO - 'LANG': 'en_US.UTF-8', 13:58:42 INFO - 'LANGUAGE': 'en_US:en', 13:58:42 INFO - 'LOGNAME': 'cltbld', 13:58:42 INFO - 'MAIL': '/var/mail/cltbld', 13:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:42 INFO - 'MOZ_NO_REMOTE': '1', 13:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:42 INFO - 'NO_EM_RESTART': '1', 13:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:42 INFO - 'PWD': '/builds/slave/test', 13:58:42 INFO - 'SHELL': '/bin/bash', 13:58:42 INFO - 'SHLVL': '1', 13:58:42 INFO - 'TERM': 'linux', 13:58:42 INFO - 'TMOUT': '86400', 13:58:42 INFO - 'USER': 'cltbld', 13:58:42 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:42 INFO - '_': '/tools/buildbot/bin/python'} 13:58:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:42 INFO - Downloading/unpacking flake8 13:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:58:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:58:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:44 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 13:58:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:58:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:58:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:58:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:58:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:58:45 INFO - no previously-included directories found matching 'docs/_build' 13:58:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:58:45 INFO - Running setup.py install for pep8 13:58:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:58:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:58:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:58:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:58:45 INFO - no previously-included directories found matching 'docs/_build' 13:58:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:58:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:58:45 INFO - Cleaning up... 13:58:45 INFO - Return code: 0 13:58:45 INFO - Running post-action listener: _resource_record_post_action 13:58:45 INFO - Running post-action listener: _start_resource_monitoring 13:58:45 INFO - Starting resource monitoring. 13:58:45 INFO - ##### 13:58:45 INFO - ##### Running install step. 13:58:45 INFO - ##### 13:58:45 INFO - Running pre-action listener: _resource_record_pre_action 13:58:45 INFO - Running main action method: install 13:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:45 INFO - Reading from file tmpfile_stdout 13:58:45 INFO - Detecting whether we're running mozinstall >=1.0... 13:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:58:46 INFO - Reading from file tmpfile_stdout 13:58:46 INFO - Output received: 13:58:46 INFO - Usage: mozinstall [options] installer 13:58:46 INFO - Options: 13:58:46 INFO - -h, --help show this help message and exit 13:58:46 INFO - -d DEST, --destination=DEST 13:58:46 INFO - Directory to install application into. [default: 13:58:46 INFO - "/builds/slave/test"] 13:58:46 INFO - --app=APP Application being installed. [default: firefox] 13:58:46 INFO - mkdir: /builds/slave/test/build/application 13:58:46 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'] 13:58:46 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 13:59:01 INFO - Reading from file tmpfile_stdout 13:59:01 INFO - Output received: 13:59:01 INFO - /builds/slave/test/build/application/firefox/firefox 13:59:01 INFO - Running post-action listener: _resource_record_post_action 13:59:01 INFO - ##### 13:59:01 INFO - ##### Running run-tests step. 13:59:01 INFO - ##### 13:59:01 INFO - Running pre-action listener: _resource_record_pre_action 13:59:01 INFO - Running main action method: run_tests 13:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:59:01 INFO - Python 2.7.3 13:59:01 INFO - Return code: 0 13:59:01 INFO - grabbing minidump binary from tooltool 13:59: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')]} 13:59:01 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 0x239c410>, '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 0x239d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x239d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:59:01 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 13:59:01 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 13:59:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:01 INFO - Return code: 0 13:59:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:59:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:59:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:59:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:59:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:59:02 INFO - Return code: 0 13:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:59:02 INFO - Using env: {'DISPLAY': ':0', 13:59:02 INFO - 'HOME': '/home/cltbld', 13:59:02 INFO - 'LANG': 'en_US.UTF-8', 13:59:02 INFO - 'LANGUAGE': 'en_US:en', 13:59:02 INFO - 'LOGNAME': 'cltbld', 13:59:02 INFO - 'MAIL': '/var/mail/cltbld', 13:59:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:59:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:02 INFO - 'MOZ_NO_REMOTE': '1', 13:59:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:02 INFO - 'NO_EM_RESTART': '1', 13:59:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:02 INFO - 'PWD': '/builds/slave/test', 13:59:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:59:02 INFO - 'SHELL': '/bin/bash', 13:59:02 INFO - 'SHLVL': '1', 13:59:02 INFO - 'TERM': 'linux', 13:59:02 INFO - 'TMOUT': '86400', 13:59:02 INFO - 'USER': 'cltbld', 13:59:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633', 13:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:02 INFO - '_': '/tools/buildbot/bin/python'} 13:59:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:59:02 INFO - mozversion application_buildid: 20160422131145 13:59:02 INFO - mozversion application_changeset: ab85f19b67b1d093e060bfe52a672a3a9995e252 13:59:02 INFO - mozversion application_display_name: Nightly 13:59:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:02 INFO - mozversion application_name: Firefox 13:59:02 INFO - mozversion application_remotingname: firefox 13:59:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:59:02 INFO - mozversion application_vendor: Mozilla 13:59:02 INFO - mozversion application_version: 48.0a1 13:59:02 INFO - mozversion platform_buildid: 20160422131145 13:59:02 INFO - mozversion platform_changeset: ab85f19b67b1d093e060bfe52a672a3a9995e252 13:59:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:59:02 INFO - mozversion platform_version: 48.0a1 13:59:02 INFO - using testdate: 1461358742 13:59:02 INFO - actual date: 1461358742 13:59:02 INFO - starting webserver on 'localhost:40048' 13:59:02 INFO - SUITE-START | Running 2 tests 13:59:02 INFO - TEST-START | dromaeo_css 13:59:02 INFO - operating with platform_type : linux_ 13:59:02 INFO - Initialising browser for dromaeo_css test... 13:59:02 INFO - TEST-INFO | started process 7440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMjs7uv/profile http://localhost:40048/getInfo.html) 13:59:07 INFO - PROCESS | 7440 | __metrics Screen width/height:1600/1200 13:59:07 INFO - PROCESS | 7440 | colorDepth:24 13:59:07 INFO - PROCESS | 7440 | Browser inner width/height: 1024/697 13:59:07 INFO - PROCESS | 7440 | __metrics 13:59:08 ERROR - PROCESS | 7440 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:59:08 INFO - TEST-INFO | 7440: exit 0 13:59:08 INFO - Browser initialized. 13:59:08 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:08 INFO - TEST-INFO | started process 7524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMjs7uv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:20 INFO - PROCESS | 7524 | RSS: Main: 155676672 13:59:20 INFO - PROCESS | 7524 | 14:00:11 INFO - PROCESS | 7524 | 1461358811421 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] 14:02:23 INFO - PROCESS | 7524 | Cycle 1(1): loaded http://localhost:40048/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40048/tests/dromaeo/cssquery-ext.html) 14:02:24 INFO - PROCESS | 7524 | RSS: Main: 255725568 14:02:24 INFO - PROCESS | 7524 | 14:05:27 INFO - PROCESS | 7524 | Cycle 1(1): loaded http://localhost:40048/tests/dromaeo/cssquery-ext.html (next: http://localhost:40048/tests/dromaeo/cssquery-jquery.html) 14:05:27 INFO - PROCESS | 7524 | RSS: Main: 247779328 14:05:27 INFO - PROCESS | 7524 | 14:08:30 INFO - PROCESS | 7524 | Cycle 1(1): loaded http://localhost:40048/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40048/tests/dromaeo/cssquery-mootools.html) 14:08:30 INFO - PROCESS | 7524 | RSS: Main: 244232192 14:08:30 INFO - PROCESS | 7524 | 14:11:32 INFO - PROCESS | 7524 | Cycle 1(1): loaded http://localhost:40048/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40048/tests/dromaeo/cssquery-prototype.html) 14:11:33 INFO - PROCESS | 7524 | RSS: Main: 231460864 14:11:33 INFO - PROCESS | 7524 | 14:14:36 INFO - PROCESS | 7524 | Cycle 1(1): loaded http://localhost:40048/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40048/tests/dromaeo/cssquery-yui.html) 14:14:36 INFO - PROCESS | 7524 | RSS: Main: 215687168 14:14:36 INFO - PROCESS | 7524 | 14:17:39 INFO - PROCESS | 7524 | Cycle 1(1): loaded http://localhost:40048/tests/dromaeo/cssquery-yui.html (next: http://localhost:40048/tests/dromaeo/cssquery-dojo.html) 14:17:40 INFO - PROCESS | 7524 | RSS: Main: 255950848 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | __start_tp_report 14:17:40 INFO - PROCESS | 7524 | _x_x_mozilla_page_load 14:17:40 INFO - PROCESS | 7524 | _x_x_mozilla_page_load_details 14:17:40 INFO - PROCESS | 7524 | |i|pagename|runs| 14:17:40 INFO - PROCESS | 7524 | |0;dojo.html;2546.427053912869;2575.0472325239666;2579.045753071364;2588.702299235588;2599.350162459385;4530.796114174862;4604.240300350442;4608.769561521919;4608.884777880555;4641.698289611177;4641.605463535603;4657.254839225725;4671.532846715327;4719.85840424787;4726.550977657125;4238.957610423902;4246.936295955563;4266.2534056540135;4291.635211007068;4387.934180987288;4309.0735491869245;4326.06989497258;4344.847930322439;4352.608265256126;4399.64802815774;4111.753294802322;4244.830206791725;4254.574542545752;4259.829606815723;4261.6803739719335;4266.360045993126;4274.700770946035;4276.23027854986;4276.2516559601945;4277.97861010696;4217.746935183868;4217.894552636178;4251.638610718092;4251.851185208503;4256.404103425523;4470.128324976631;4489;4493.4832494263255;4497.190505709003;4513.368128462018;4828.37231159947;4911.950880491221;4914.459409464956;4918.754062296871;4971.229459433794;4918.188498897677;4962.60299176065;4978.079055374767;4995.250712393134;5020.1214787412055;4637.211674015425;4649.209634362167;4687.81248750053;4687.9765601171775;4722.055588882237;4933.333999909966;5042.596592272683;5111.412187598474;5121.897562048738;5121.948780512222;4862.17343051682;4889.339939108246;4892.363992681;4927.285543596158;4934.925976110361;4979.253112033224;4985.227289770091;4985.576226020757;4987.975060124676;5033.47148549397;4762.3808904842845;4878.195097808822;4936.950630493721;4956.207006878882;5001.9245862139815;4915.311856340115;4937.456879743226;4938.061768264019;4939.185034469344;4963.329950456714;4281.700280980302;4282.807273672693;4288.013756835945;4330.826766929351;4332.241857674957;3658.5975542690285;3696.759710618855;3723.739338246297;3725.2177042820767;3769.095417099931;4279.33670281107;4295.570442955679;4296.484421869396;4316.266234740102;4341.45731783527;5003;5022.472640372781;5027.245913113063;5029.823956161516;5075.771590278372;4179.03882107111;4216.683748718859;4278.422412974209;4278.679099067583;4290.313549832074;4485.506594274627;4492.932606010912;4493.707908985905;4520.095980803852;4525.52481989393;4731.858044258678;4732.763361831963;4737.957649317144;4741.786619602195;4794.041191761662;4834.347363106076;4944.975275123601;4999.425066117443;5055.393352797688;5065.898682026413;4669.066186762593;4670.439547254351;4683.742394168354;4684.320773487893;4712.835050773207;4864.27035944597;4870.707757534559;4876.195427754381;4877.561019508261;4923.261510773413;4786.688865223749;4915.606751459946;5013.674111182761;5016.673916195436;5056.772445240046;4825.324454576432;4827.300041493893;4828.275758636232;4836.606511850111;4895.46149923501;4751.738654373904;4799.880002999813;4834.8791280216865;4835.661503694708;4891.461939186615;4783.258594917794;4831.613470922388;4834.8791280218275;4868.075065737498;4885.682430641997;4841.782119804547;4901.3383193268455;4901.338319326987;4907.631927605373;4948.777305021211;4682;4747.145513807548;4781.6891902026255;4809.9038019240115;4811.350467686958 14:17:40 INFO - PROCESS | 7524 | |1;ext.html;569.67243834795;588.3880764005435;606.2906399512569;615.4922189193915;617.8455386153462;27182.184534463948;34417;35398.82300588494;35415.468767968436;35461.93614191575;37164.628353716456;38103.42844857329;38205.61794382055;38231.42652860202;38266.23467530648;7360.411167106646;7530.435217358692;7779;9568.425894446356;9893.604255829758;9752.171065459444;9886.357386769872;9904.356216845918;9904.405735655884;9908.702738917807;9854.113129818315;9891.50542472877;9985.25110616703;9990.600375984952;9997.750056248615;7431.962840185792;9881.16010139139;10267.075963163277;10275.075243228071;10282.640107596199;9786.90213097867;9889.703308900744;9916.851247231298;9917.90082099177;9939.155171810406;35101;35406.46890296647;35641.82179089114;35701.28597428063;35756.82121589375;3188.5536024956523;3220.4686226772556;3428.674275943781;3748.9250214995545;3760.492333534965;28812;29215.269618259714;29489.557656635166;29540.409191816045;29616.259593510335;3327.2846338037198;3413.607435144965;3413.6586341365914;3425.5889293284717;3524.6122926478065;244207;245989.77005115038;247914;248283;249313;53120.734396328546;53461.465385346426;53839.19241211385;53926.65183370447;53946;57766;57820.63972963055;58152.418475815546;58155.41844581585;58247;12126.939365303293;13052.738945221232;13213;13229.140105893086;13318.200907945555;9143.177114059767;9151.130642588943;9152.450852948845;9159.679411220575;10576.153907687367;15851.682966340608;16080.356785728674;16101.19494025294;16110.194490275439;16151.192440377934;5819;6223.315435302113;6294.0173845238605;6327.145835312174;6334.271558770801;873.8121303919688;912.1972664055588;950.7765675066354;965.3918031640022;1016.7458135466134;27871.30321741932;27921.72078279232;28045.57931631027;28865.422691546053;29368;985.7880555680563;1024.4928760263717;1038.745507350704;1056.0653821368144;1066.802641511323;13993.440262389391;15356.232188390535;15381.46164884246;15388.769168462482;15579.61050973712;338334;341377;343942;344296;346741;49340.25989610159;49686.75156624266;49700;49792.25311620328;49792.50207497951;1062.2139616683753;1189.423129782055;1224.5407972010673;1258.7230809221955;1302.8827405533548;24746.133885313928;25773.484530309663;25901;26004.21987340383;26167.476650467266;35122.83894449512;35334.82332588424;35632.28735425329;35672.28655426929;35760.28479430345;186848;187771;189258;189378;189424;22906.54186916219;23859;25059;25653;25922.35194120162;35713.821430892676;36437.27125457529;43049.569504304556;44535.331970019826;45386;31404.214894627818;35314.76398326046;35576.64423355837;35687.64312356843;36039.63960360363;34917;35086.82456587701;35237.82381088078;35462;35579;34470.65529344675;34598.65401346055;34717.652823472454;34912.30175396529;35049.299014020085;30656.693433065382;30826;31351.86481351938;31416.214594635316;31511.369772604878;24053;24347.51304973926;24733.752662473144;24971.50056998886;25063.624045639695 14:17:40 INFO - PROCESS | 7524 | |2;jquery.html;385.8244498753069;390.23708649590054;390.74992005116724;392.5836476487222;404.42773475532124;12604.495820167182;12907.290099044549;15209.4676686316;16148.919255403722;16156.596085097879;14188.645283867883;15016.624584385396;15018.624534386647;15022.699546009073;15026.474073407433;5123.154679477891;5254.21186821976;5309.946900531003;5316.043112239795;5317.548008419289;3700.296943580711;4809.543093406139;5214.895702085956;5220.29526013987;5266.3943646480575;6087.939120608781;6108.144859719643;6117.082437634346;6120.296165940907;6127.5404344674325;6008.188894499231;6056.364081771417;6068.120122582245;6070.484008859252;6073;5171.896562068775;5343.545798607123;5354.27717258169;5355.919661205085;5384.3538775346815;18819.90590047055;20705;20814.47963800902;21099.15603375863;21119.683204751942;1980.0996013956226;2050.149188086942;2092.1213090502024;2200.680901269307;2564.025670245295;12821.67945801353;12945.417456214493;13071.607851764462;13172.143810652276;13635.795463068062;1730.731736580832;1786.767720196379;1793.3812834572182;1828.9359872404402;1847.131848031423;46183.53816461859;50481.76272874393;57213.713931430495;62116.68941655308;71099.64450177767;9323.720288391223;9329.766755831159;9486.430814151036;9566.091221333962;9712.70861874145;12616.936915315548;12715.745685086247;12743.553975610994;12750.61748147557;12833.101682882296;7102.644867756591;7121.145462544528;7189.92810071903;7295.671694773748;7324.414046876237;6984.161900571964;7145.214026457085;7197;7276.326444917699;7283.526570772883;5994.280686317583;5999.880002399927;6042.486388656926;6063.484603808725;6107.373829253374;1685.5196269063258;1785.1342099081935;1808.1049880309067;1825.7626508553803;1858.135966775456;913.7258822353267;918.1048477734289;984.3650845204803;991.0535438656066;1018.1905385218621;16837.57906052334;17156.142192890555;17538.736918946226;17660.646787064445;17906.194221260073;892.4957399069505;903.4940433357209;924.5654542365078;932.2169377722745;942.7737343037621;9723.562439690231;10142.847857282146;10228.335158214692;10298.897011029943;10336.224783141295;419481;423188;425664;426014;428471;73218.63390683013;73611;75005.24994750092;76829.61585192039;77153;879.305348774461;943.5518128888723;973.0415540692412;993;995.9800803983879;15675.608109797346;16052.438164664181;16121.919390402973;16202.67594648124;16211.133710428345;32983.34033319272;33670;33839.83080084682;33921.3215735679;34396.14009649779;39531;45020;45219.321710175034;45637.54362456333;49843.25235121403;7562.621868906643;7894.881576776468;7941.12647608751;7993.920060799318;8016.7194148204535;8751.081136480578;11155.72110697239;12043.698907527032;12087.697807554881;12397.876021239672;10208.846867296848;10452.947735261276;10507.632232871812;10521;10787.622433215114;9873.753156171153;10081.949590252001;10253;10277.794444111225;10317.9484102579;10254.282200246209;10470;10747.140228781835;10750.301230419998;10982;7783.143854176149;7803.648835802289;7850.725224617111;7980.401469889897;8008;10155.847662284923;10611.41637209961;10619.893801062199;10675.199360047873;10784.946075269574 14:17:40 INFO - PROCESS | 7524 | |3;mootools.html;1212.0545974140168;1254.7427777305654;1294.760469313177;1351.1015174908687;1817.064211930856;6662.333766623341;6941.791746247614;7540.585267810268;7717.344025757803;7749.535027898316;7575.053118360205;7621.961890190555;7686.5003774754605;7697.615119244029;7706.113796913357;1855.6103218324167;2123.6708310211943;2170.6635471501904;2199.967000494994;2200.3069033254556;2183.050373087704;2193.473566344082;2202.1631779923687;2206.6248737714627;2212.4026512841524;2183.5960347335713;2205.8676479411206;2217.4013016485537;2219.1012639880873;2220.811231045363;1809.0773705410204;2086.467950672569;2087.9060442280133;2170.142793596536;2178.967315490269;2138.8930553472264;2161.2543672432985;2164.751053628837;2165.3936897668677;2168.2844661261747;7449.925500744977;7492.925070749332;7496.887546686749;7507.136679281898;7507.8498430031095;4497.235469970113;4693.225617773063;4701.224297990828;4702.694324868872;4703.623710103184;2951.335949411365;3029.545568164771;3108.797928134664;3126.249700071989;3137.278425962019;980.7499087732654;998.3610489286863;1001.7746007148406;1001.8597396364515;1020.9744756381076;10503;10689.572417103307;10750.731231719192;10775.622853200179;10820.567177312898;4244.342126970325;4252.659787217015;4424.6239069678795;4425.645948324126;4526.660500462479;9294.86057709135;9317.627294908263;9318.068193180628;9319.301052421095;9353.625854965861;4839.685420447659;4848.80604775805;4859.611231101574;4875.756212189376;4880.048390563806;3720.497732806091;4219.156168766259;4304.031592891574;4306.698531102793;4312.094460163338;3714.1457464783252;3730.5896351401325;3826.0626146593704;3861.0540417597867;3892.3188442022533;1211.5335595795682;1251.7934540800848;1261.9558315458914;1265.3230521670862;1274.6112435707014;777.0946846923271;790.9564973926489;799.2407213147417;808.1312588966885;809.8258874342044;5280.339957505312;5451.536619387317;5478.671279723229;5498.725063746797;5548.167774833726;915.8809354783835;922.3405265235255;941.3081385181886;949.3307218411004;958.3262697075082;3781.205946751213;3847.5575308839284;3850.4609354690365;3858.6141385861188;3907.941380879289;9157.450552966844;9561.235101191887;9614.663486778069;9617.27870409722;9632.13310802017;9668.129868311746;9830.066143716336;9866.901330986742;9908.157806586376;9932;6979.93020069803;7017;7042.436605071582;7048.259932707095;7093.361597456254;5168.0697474454955;5207.505286997729;5262.289590905179;5286.9471305288;5357.973210133924;8335.541545214828;8404.831903361775;8575.099614540384;8616.612252448529;8679.392442528962;8652.048274689652;8742.781430464289;8832.867506987528;8880.333974951775;8902.287816974496;6257.530685198537;6575.572587781779;6672;6690.160205943404;6938.930610693828;7450.888236676563;7464.738734144496;7521.924780752122;7534.886976695244;7543.283388078124;6448.613083215022;6758.628275444898;6799.286074962058;6848.554843935129;6919.446444284345;6614.801555953329;6628.801135965929;6636.502262330441;6712.194536655633;6755.256921738703;6280.7487700491465;6474;6489.5781774184525;6532.150820393318;6544.181977252843;4612.930806037845;4682.22743247374;4754.619630429626;4780.95219047805;4814.662973591815;4568.748718820497;4659.2079346511855;4687.437507499122;4754.904901902012;4770.976145119253 14:17:40 INFO - PROCESS | 7524 | |4;prototype.html;322.31347230399246;322.54199037366936;322.6724874252634;329.8120071559209;333.12056171706683;5130.974345128278;5141.691498510092;5157.406898206707;5177.482251774821;5181.274621552986;5094.974525127369;5100.617453690969;5101.668391554546;5101.693898366091;5118.692878427288;3813.6949044076478;3878.3019056569806;4000.4999375078114;4031.919361612766;4074.8777536673947;4025.0339918419513;4040.9595904041025;4049.1699201663737;4053;4059.7361171523758;3772.830222639988;3982.26328129297;3999.1002024544537;4006.8597599084037;4013.357862741962;3890.396988466792;3963.929738970476;3986.720929534934;4022.3363145081025;4027.7180597358197;3560.964390356089;3572.3034008368377;3577.910552236189;3579.552555930509;3588.7308451866215;4916.877078073041;4919.311296418504;4919.606431485508;4922.114019476493;4926.433460152092;4318.892027699301;4506.504284528699;4541.6593755468475;4572;4635.907281854344;5301.893962120775;5318.590573498026;5366.9463305366835;5377.81177658784;5378.569714422837;3802.8098595070414;3809.8095095245403;3812.90467738306;3821.8280177392085;3829.2341531693496;5511.889762204773;5578.832635020955;5613.578981576398;5630.943690563083;5663.065594176997;3873.8837834865;3914.530256369254;3919.6080391960577;3922.764634121962;3928.4303775952326;3942.3889297158985;3959.604039596017;3971.543272523639;3972.66232370246;3982.2234664240773;4441.133978874153;4495.201919232333;4521.231390663529;4538.797218737037;4540.137373898949;5361.329833770778;5397.217403476552;5403.378611459654;5413.431589683105;5432.185172224198;1368.637311112556;1370.2460850111872;1378.5864240727742;1386.6671998720235;1387.7502049631164;871.3551971541013;908.1100521488846;931;935.9298052646079;945.4752612300102;4653.790579423934;4662.953370466252;4668.50980647034;4673.6728429009645;4680.438347398334;5490.6980116094;5504.4770746778995;5505.174223866452;5505.3393592768325;5513.862153446196;4554.840580579664;4652.744099074584;4673.322368256584;4692.906141877212;4781.95218047822;2971.301744090137;2995.8651860666323;2996.5055765798834;3004.173852190665;3004.7596192304563;5302.814401496006;5304.549113325334;5309.522143007148;5312.840614781563;5325.866853328698;5559.6664200148125;5716;5754.395788442237;5762.279715035621;5787.160861675034;5271.156614941591;5287.814926477555;5294.338207724035;5299.231611416323;5303.7348132593215;5386.016059541646;5535.7785688572;5563.610547261653;5616.213730077874;5626.521745651666;5465.699386533779;5481.150421684645;5501.174823776466;5504.504594586507;5511.917321240105;5215.76529056201;5243;5255.316808814982;5256.500632439912;5276;3802.9239415210986;3866.226754649025;3866.5940076291586;3876.825542850522;3880.611938806097;5539.169124631338;5547.805826796042;5571.860703482445;5571.8885622288135;5579.716665167116;5355.732213389393;5368.32895888014;5396.541293990055;5399.379071406838;5406.702631355156;5267.104592219409;5329.7868085277705;5367.758450869798;5370.301860758076;5403.9459605403445;5053.140966035856;5287.524122828964;5301.363836339664;5317.760700768397;5320.680759154463;5203.49098761355;5418.566514678895;5467.753951072132;5468.28912241406;5476.2607048048;5319.627626066138;5323.361196656426;5328.70692111922;5331.306930099217;5336.813211537577 14:17:40 INFO - PROCESS | 7524 | |5;yui.html;649.3701109923372;676.1750664189689;696.188939885034;704.6899364279719;741.1921006103348;12492.812607810878;12757.553485627981;12888.16226945248;12906.612801615955;12917.547885823999;12073.698157546043;12275.44760485778;12360.814587781191;12421.875781242185;12444.315562644051;812.6749300279877;828.2711214131585;828.6022709099636;828.6975254032295;828.888100106484;648.2933602373412;788.1055002572065;798.7084714079348;827.983440331193;829.6473998550622;854.9273311768507;859.7807559072428;860.9397342186049;861.4529773593782;861.8664107063415;850.3877208409966;851.4252879306474;851.748734123435;852.3266619370689;852.5737131434283;497.9502049794992;595.752762603519;623.4139908486054;623.5323507369473;624.2446639566085;12351.258924464471;12379.566715164927;12389;12418.192817466836;12424.192427492184;11646.941765291203;12440.626781196579;12452.128351015432;12572.622821315375;12602.117851750381;11275.32348059119;11287.887121128766;11373.31760094397;11421.54313827446;11464.25482343645;4188.958110418887;4237.957620423787;4253;4397.780110994469;4415.492218394894;42863.142737145085;44233.33649995253;44281;44281.11437771226;44307.33538996918;10241.180705543538;10262.58949642006;10372.481375931173;10528.315659482108;10568;17504.474865754048;17697.203625836868;17707.114644267735;17768.555786105193;17775.822241777416;7030;7169.533980291264;7184.544274007684;7282.781516554512;7297.124345078624;3895.3767397216875;3942.8619998299923;3967.1867267210155;3997.960020399817;4016.859409920697;2822.5766135079903;2890.0173940859786;2893.160983314815;2896.5799959005826;2901.448724742292;530.8911673107003;533.6051322021754;537.532346858228;537.967721936685;545.929029226198;589.4105894105894;595.5087053181143;597.357840321656;601.0653433910311;611.3794498583941;7802.180771019075;8305.335573154132;8327.125651806595;8518.063013068557;8525.40322177454;606.3633185155569;616.2836500346514;649.5226008883467;649.9252585952676;679.0323788601223;3833.8274777635074;3903.9609603904164;3963.742356746802;3979.522457305142;4057.8173982170874;45263.77368113138;54267.85982102637;54467.72766136144;54558.45441545613;54628.45371546313;41308.586914131076;41637.375439368436;41689.1662166761;41706.582934170874;42373.1525369497;38605.613943860204;38607.80696096501;38973;38986.22027559433;39289.999999999425;7780.2219778021745;8421.15788421153;8626.827463450822;8646.610902509528;8728.258098061737;26666;26731.465370692087;27751.167464976083;28384.57423138696;28746;34372.65627343694;37100.81449592735;37404.62595374011;37678;37737.81131094327;10701.51843167075;10977.231593788678;11013.394263315595;11016.559337626406;11031.22781405294;11200.943995279971;11296.6046188383;11767.823482647596;11958.039879944146;12129.45417456199;8001.679932802856;10441.425721585081;10453;11257.380844053656;11727.120465964916;10952.178586606196;11494.712632184262;11532.654020379403;11868.58459953932;12023.579174728842;10963.451827408438;11083.667489975314;11331.490082946122;11459.770804584028;11478.94260528692;9142.131497507726;9378.859317110113;9444.338896277195;9645.08371704687;9710.854337185088;9649.118456617267;10008.665942844691;10071.348253112226;10117.08946194846;10146.391216527032 14:17:40 INFO - PROCESS | 7524 | __end_tp_report 14:17:40 INFO - PROCESS | 7524 | __start_cc_report 14:17:40 INFO - PROCESS | 7524 | _x_x_mozilla_cycle_collect,903 14:17:40 INFO - PROCESS | 7524 | __end_cc_report 14:17:40 INFO - PROCESS | 7524 | __startTimestamp1461359860247__endTimestamp 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | ------- Summary: start ------- 14:17:40 INFO - PROCESS | 7524 | Number of tests: 6 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | [#0] dojo.html Cycles:165 Average:4594.72 Median:4732.76 stddev:480.14 (10.1%) stddev-sans-first:453.93 14:17:40 INFO - PROCESS | 7524 | Values: 2546.4 2575.0 2579.0 2588.7 2599.4 4530.8 4604.2 4608.8 4608.9 4641.7 4641.6 4657.3 4671.5 4719.9 4726.6 4239.0 4246.9 4266.3 4291.6 4387.9 4309.1 4326.1 4344.8 4352.6 4399.6 4111.8 4244.8 4254.6 4259.8 4261.7 4266.4 4274.7 4276.2 4276.3 4278.0 4217.7 4217.9 4251.6 4251.9 4256.4 4470.1 4489.0 4493.5 4497.2 4513.4 4828.4 4912.0 4914.5 4918.8 4971.2 4918.2 4962.6 4978.1 4995.3 5020.1 4637.2 4649.2 4687.8 4688.0 4722.1 4933.3 5042.6 5111.4 5121.9 5121.9 4862.2 4889.3 4892.4 4927.3 4934.9 4979.3 4985.2 4985.6 4988.0 5033.5 4762.4 4878.2 4937.0 4956.2 5001.9 4915.3 4937.5 4938.1 4939.2 4963.3 4281.7 4282.8 4288.0 4330.8 4332.2 3658.6 3696.8 3723.7 3725.2 3769.1 4279.3 4295.6 4296.5 4316.3 4341.5 5003.0 5022.5 5027.2 5029.8 5075.8 4179.0 4216.7 4278.4 4278.7 4290.3 4485.5 4492.9 4493.7 4520.1 4525.5 4731.9 4732.8 4738.0 4741.8 4794.0 4834.3 4945.0 4999.4 5055.4 5065.9 4669.1 4670.4 4683.7 4684.3 4712.8 4864.3 4870.7 4876.2 4877.6 4923.3 4786.7 4915.6 5013.7 5016.7 5056.8 4825.3 4827.3 4828.3 4836.6 4895.5 4751.7 4799.9 4834.9 4835.7 4891.5 4783.3 4831.6 4834.9 4868.1 4885.7 4841.8 4901.3 4901.3 4907.6 4948.8 4682.0 4747.1 4781.7 4809.9 4811.4 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | [#1] ext.html Cycles:180 Average:41960.74 Median:35093.91 stddev:70081.79 (199.7%) stddev-sans-first:70209.48 14:17:40 INFO - PROCESS | 7524 | Values: 569.7 588.4 606.3 615.5 617.8 27182.2 34417.0 35398.8 35415.5 35461.9 37164.6 38103.4 38205.6 38231.4 38266.2 7360.4 7530.4 7779.0 9568.4 9893.6 9752.2 9886.4 9904.4 9904.4 9908.7 9854.1 9891.5 9985.3 9990.6 9997.8 7432.0 9881.2 10267.1 10275.1 10282.6 9786.9 9889.7 9916.9 9917.9 9939.2 35101.0 35406.5 35641.8 35701.3 35756.8 3188.6 3220.5 3428.7 3748.9 3760.5 28812.0 29215.3 29489.6 29540.4 29616.3 3327.3 3413.6 3413.7 3425.6 3524.6 244207.0 245989.8 247914.0 248283.0 249313.0 53120.7 53461.5 53839.2 53926.7 53946.0 57766.0 57820.6 58152.4 58155.4 58247.0 12126.9 13052.7 13213.0 13229.1 13318.2 9143.2 9151.1 9152.5 9159.7 10576.2 15851.7 16080.4 16101.2 16110.2 16151.2 5819.0 6223.3 6294.0 6327.1 6334.3 873.8 912.2 950.8 965.4 1016.7 27871.3 27921.7 28045.6 28865.4 29368.0 985.8 1024.5 1038.7 1056.1 1066.8 13993.4 15356.2 15381.5 15388.8 15579.6 338334.0 341377.0 343942.0 344296.0 346741.0 49340.3 49686.8 49700.0 49792.3 49792.5 1062.2 1189.4 1224.5 1258.7 1302.9 24746.1 25773.5 25901.0 26004.2 26167.5 35122.8 35334.8 35632.3 35672.3 35760.3 186848.0 187771.0 189258.0 189378.0 189424.0 22906.5 23859.0 25059.0 25653.0 25922.4 35713.8 36437.3 43049.6 44535.3 45386.0 31404.2 35314.8 35576.6 35687.6 36039.6 34917.0 35086.8 35237.8 35462.0 35579.0 34470.7 34598.7 34717.7 34912.3 35049.3 30656.7 30826.0 31351.9 31416.2 31511.4 24053.0 24347.5 24733.8 24971.5 25063.6 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | [#2] jquery.html Cycles:180 Average:24745.48 Median:421334.50 stddev:69590.23 (16.5%) stddev-sans-first:69761.42 14:17:40 INFO - PROCESS | 7524 | Values: 385.8 390.2 390.7 392.6 404.4 12604.5 12907.3 15209.5 16148.9 16156.6 14188.6 15016.6 15018.6 15022.7 15026.5 5123.2 5254.2 5309.9 5316.0 5317.5 3700.3 4809.5 5214.9 5220.3 5266.4 6087.9 6108.1 6117.1 6120.3 6127.5 6008.2 6056.4 6068.1 6070.5 6073.0 5171.9 5343.5 5354.3 5355.9 5384.4 18819.9 20705.0 20814.5 21099.2 21119.7 1980.1 2050.1 2092.1 2200.7 2564.0 12821.7 12945.4 13071.6 13172.1 13635.8 1730.7 1786.8 1793.4 1828.9 1847.1 46183.5 50481.8 57213.7 62116.7 71099.6 9323.7 9329.8 9486.4 9566.1 9712.7 12616.9 12715.7 12743.6 12750.6 12833.1 7102.6 7121.1 7189.9 7295.7 7324.4 6984.2 7145.2 7197.0 7276.3 7283.5 5994.3 5999.9 6042.5 6063.5 6107.4 1685.5 1785.1 1808.1 1825.8 1858.1 913.7 918.1 984.4 991.1 1018.2 16837.6 17156.1 17538.7 17660.6 17906.2 892.5 903.5 924.6 932.2 942.8 9723.6 10142.8 10228.3 10298.9 10336.2 419481.0 423188.0 425664.0 426014.0 428471.0 73218.6 73611.0 75005.2 76829.6 77153.0 879.3 943.6 973.0 993.0 996.0 15675.6 16052.4 16121.9 16202.7 16211.1 32983.3 33670.0 33839.8 33921.3 34396.1 39531.0 45020.0 45219.3 45637.5 49843.3 7562.6 7894.9 7941.1 7993.9 8016.7 8751.1 11155.7 12043.7 12087.7 12397.9 10208.8 10452.9 10507.6 10521.0 10787.6 9873.8 10081.9 10253.0 10277.8 10317.9 10254.3 10470.0 10747.1 10750.3 10982.0 7783.1 7803.6 7850.7 7980.4 8008.0 10155.8 10611.4 10619.9 10675.2 10784.9 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | [#3] mootools.html Cycles:180 Average:5146.47 Median:5271.31 stddev:2833.88 (53.8%) stddev-sans-first:2826.40 14:17:40 INFO - PROCESS | 7524 | Values: 1212.1 1254.7 1294.8 1351.1 1817.1 6662.3 6941.8 7540.6 7717.3 7749.5 7575.1 7622.0 7686.5 7697.6 7706.1 1855.6 2123.7 2170.7 2200.0 2200.3 2183.1 2193.5 2202.2 2206.6 2212.4 2183.6 2205.9 2217.4 2219.1 2220.8 1809.1 2086.5 2087.9 2170.1 2179.0 2138.9 2161.3 2164.8 2165.4 2168.3 7449.9 7492.9 7496.9 7507.1 7507.8 4497.2 4693.2 4701.2 4702.7 4703.6 2951.3 3029.5 3108.8 3126.2 3137.3 980.7 998.4 1001.8 1001.9 1021.0 10503.0 10689.6 10750.7 10775.6 10820.6 4244.3 4252.7 4424.6 4425.6 4526.7 9294.9 9317.6 9318.1 9319.3 9353.6 4839.7 4848.8 4859.6 4875.8 4880.0 3720.5 4219.2 4304.0 4306.7 4312.1 3714.1 3730.6 3826.1 3861.1 3892.3 1211.5 1251.8 1262.0 1265.3 1274.6 777.1 791.0 799.2 808.1 809.8 5280.3 5451.5 5478.7 5498.7 5548.2 915.9 922.3 941.3 949.3 958.3 3781.2 3847.6 3850.5 3858.6 3907.9 9157.5 9561.2 9614.7 9617.3 9632.1 9668.1 9830.1 9866.9 9908.2 9932.0 6979.9 7017.0 7042.4 7048.3 7093.4 5168.1 5207.5 5262.3 5286.9 5358.0 8335.5 8404.8 8575.1 8616.6 8679.4 8652.0 8742.8 8832.9 8880.3 8902.3 6257.5 6575.6 6672.0 6690.2 6938.9 7450.9 7464.7 7521.9 7534.9 7543.3 6448.6 6758.6 6799.3 6848.6 6919.4 6614.8 6628.8 6636.5 6712.2 6755.3 6280.7 6474.0 6489.6 6532.2 6544.2 4612.9 4682.2 4754.6 4781.0 4814.7 4568.7 4659.2 4687.4 4754.9 4771.0 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | [#4] prototype.html Cycles:180 Average:4471.47 Median:5124.83 stddev:1301.53 (25.4%) stddev-sans-first:1267.38 14:17:40 INFO - PROCESS | 7524 | Values: 322.3 322.5 322.7 329.8 333.1 5131.0 5141.7 5157.4 5177.5 5181.3 5095.0 5100.6 5101.7 5101.7 5118.7 3813.7 3878.3 4000.5 4031.9 4074.9 4025.0 4041.0 4049.2 4053.0 4059.7 3772.8 3982.3 3999.1 4006.9 4013.4 3890.4 3963.9 3986.7 4022.3 4027.7 3561.0 3572.3 3577.9 3579.6 3588.7 4916.9 4919.3 4919.6 4922.1 4926.4 4318.9 4506.5 4541.7 4572.0 4635.9 5301.9 5318.6 5366.9 5377.8 5378.6 3802.8 3809.8 3812.9 3821.8 3829.2 5511.9 5578.8 5613.6 5630.9 5663.1 3873.9 3914.5 3919.6 3922.8 3928.4 3942.4 3959.6 3971.5 3972.7 3982.2 4441.1 4495.2 4521.2 4538.8 4540.1 5361.3 5397.2 5403.4 5413.4 5432.2 1368.6 1370.2 1378.6 1386.7 1387.8 871.4 908.1 931.0 935.9 945.5 4653.8 4663.0 4668.5 4673.7 4680.4 5490.7 5504.5 5505.2 5505.3 5513.9 4554.8 4652.7 4673.3 4692.9 4782.0 2971.3 2995.9 2996.5 3004.2 3004.8 5302.8 5304.5 5309.5 5312.8 5325.9 5559.7 5716.0 5754.4 5762.3 5787.2 5271.2 5287.8 5294.3 5299.2 5303.7 5386.0 5535.8 5563.6 5616.2 5626.5 5465.7 5481.2 5501.2 5504.5 5511.9 5215.8 5243.0 5255.3 5256.5 5276.0 3802.9 3866.2 3866.6 3876.8 3880.6 5539.2 5547.8 5571.9 5571.9 5579.7 5355.7 5368.3 5396.5 5399.4 5406.7 5267.1 5329.8 5367.8 5370.3 5403.9 5053.1 5287.5 5301.4 5317.8 5320.7 5203.5 5418.6 5467.8 5468.3 5476.3 5319.6 5323.4 5328.7 5331.3 5336.8 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - PROCESS | 7524 | [#5] yui.html Cycles:180 Average:12549.09 Median:4007.41 stddev:13653.98 (340.7%) stddev-sans-first:13663.04 14:17:40 INFO - PROCESS | 7524 | Values: 649.4 676.2 696.2 704.7 741.2 12492.8 12757.6 12888.2 12906.6 12917.5 12073.7 12275.4 12360.8 12421.9 12444.3 812.7 828.3 828.6 828.7 828.9 648.3 788.1 798.7 828.0 829.6 854.9 859.8 860.9 861.5 861.9 850.4 851.4 851.7 852.3 852.6 498.0 595.8 623.4 623.5 624.2 12351.3 12379.6 12389.0 12418.2 12424.2 11646.9 12440.6 12452.1 12572.6 12602.1 11275.3 11287.9 11373.3 11421.5 11464.3 4189.0 4238.0 4253.0 4397.8 4415.5 42863.1 44233.3 44281.0 44281.1 44307.3 10241.2 10262.6 10372.5 10528.3 10568.0 17504.5 17697.2 17707.1 17768.6 17775.8 7030.0 7169.5 7184.5 7282.8 7297.1 3895.4 3942.9 3967.2 3998.0 4016.9 2822.6 2890.0 2893.2 2896.6 2901.4 530.9 533.6 537.5 538.0 545.9 589.4 595.5 597.4 601.1 611.4 7802.2 8305.3 8327.1 8518.1 8525.4 606.4 616.3 649.5 649.9 679.0 3833.8 3904.0 3963.7 3979.5 4057.8 45263.8 54267.9 54467.7 54558.5 54628.5 41308.6 41637.4 41689.2 41706.6 42373.2 38605.6 38607.8 38973.0 38986.2 39290.0 7780.2 8421.2 8626.8 8646.6 8728.3 26666.0 26731.5 27751.2 28384.6 28746.0 34372.7 37100.8 37404.6 37678.0 37737.8 10701.5 10977.2 11013.4 11016.6 11031.2 11200.9 11296.6 11767.8 11958.0 12129.5 8001.7 10441.4 10453.0 11257.4 11727.1 10952.2 11494.7 11532.7 11868.6 12023.6 10963.5 11083.7 11331.5 11459.8 11478.9 9142.1 9378.9 9444.3 9645.1 9710.9 9649.1 10008.7 10071.3 10117.1 10146.4 14:17:40 INFO - PROCESS | 7524 | -------- Summary: end -------- 14:17:40 INFO - PROCESS | 7524 | 14:17:40 INFO - TEST-INFO | 7524: exit 0 14:17:40 INFO - TEST-OK | dromaeo_css | took 1117943ms 14:17:40 INFO - TEST-START | kraken 14:17:40 INFO - operating with platform_type : linux_ 14:17:40 INFO - Initialising browser for kraken test... 14:17:40 INFO - TEST-INFO | started process 7708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFyrIxU/profile http://localhost:40048/getInfo.html) 14:17:45 INFO - PROCESS | 7708 | __metrics Screen width/height:1600/1200 14:17:45 INFO - PROCESS | 7708 | colorDepth:24 14:17:45 INFO - PROCESS | 7708 | Browser inner width/height: 1024/697 14:17:45 INFO - PROCESS | 7708 | __metrics 14:17:46 ERROR - PROCESS | 7708 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:17:46 INFO - TEST-INFO | 7708: exit 0 14:17:46 INFO - Browser initialized. 14:17:46 INFO - Running cycle 1/1 for kraken test... 14:17:46 INFO - TEST-INFO | started process 7788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFyrIxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:58 INFO - PROCESS | 7788 | RSS: Main: 156119040 14:17:58 INFO - PROCESS | 7788 | 14:18:01 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40048/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:02 INFO - PROCESS | 7788 | RSS: Main: 210313216 14:18:02 INFO - PROCESS | 7788 | 14:18:05 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40048/tests/kraken/driver.html?testName=audio-dft) 14:18:06 INFO - PROCESS | 7788 | RSS: Main: 197046272 14:18:06 INFO - PROCESS | 7788 | 14:18:09 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40048/tests/kraken/driver.html?testName=audio-fft) 14:18:09 INFO - PROCESS | 7788 | RSS: Main: 266678272 14:18:09 INFO - PROCESS | 7788 | 14:18:11 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40048/tests/kraken/driver.html?testName=audio-oscillator) 14:18:12 INFO - PROCESS | 7788 | RSS: Main: 174825472 14:18:12 INFO - PROCESS | 7788 | 14:18:14 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40048/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:15 INFO - PROCESS | 7788 | RSS: Main: 179355648 14:18:15 INFO - PROCESS | 7788 | 14:18:18 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40048/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:19 INFO - PROCESS | 7788 | RSS: Main: 214663168 14:18:19 INFO - PROCESS | 7788 | 14:18:22 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40048/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:23 INFO - PROCESS | 7788 | RSS: Main: 213188608 14:18:23 INFO - PROCESS | 7788 | 14:18:26 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40048/tests/kraken/driver.html?testName=json-parse-financial) 14:18:26 INFO - PROCESS | 7788 | RSS: Main: 214593536 14:18:26 INFO - PROCESS | 7788 | 14:18:28 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40048/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:29 INFO - PROCESS | 7788 | RSS: Main: 201592832 14:18:29 INFO - PROCESS | 7788 | 14:18:31 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:31 INFO - PROCESS | 7788 | RSS: Main: 203800576 14:18:31 INFO - PROCESS | 7788 | 14:18:33 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:34 INFO - PROCESS | 7788 | RSS: Main: 215511040 14:18:34 INFO - PROCESS | 7788 | 14:18:37 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:18:37 INFO - PROCESS | 7788 | RSS: Main: 225951744 14:18:37 INFO - PROCESS | 7788 | 14:18:40 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:41 INFO - PROCESS | 7788 | RSS: Main: 222441472 14:18:41 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | Cycle 1(1): loaded http://localhost:40048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40048/tests/kraken/driver.html?testName=ai-astar) 14:18:43 INFO - PROCESS | 7788 | RSS: Main: 285937664 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | __start_tp_report 14:18:43 INFO - PROCESS | 7788 | _x_x_mozilla_page_load 14:18:43 INFO - PROCESS | 7788 | _x_x_mozilla_page_load_details 14:18:43 INFO - PROCESS | 7788 | |i|pagename|runs| 14:18:43 INFO - PROCESS | 7788 | |0;ai-astar;113;114;109;113;117;115;103;115;116;115 14:18:43 INFO - PROCESS | 7788 | |1;audio-beat-detection;161;138;166;191;142;164;165;140;199;136 14:18:43 INFO - PROCESS | 7788 | |2;audio-dft;160;160;161;162;162;162;161;162;160;162 14:18:43 INFO - PROCESS | 7788 | |3;audio-fft;74;74;117;110;75;77;76;120;105;76 14:18:43 INFO - PROCESS | 7788 | |4;audio-oscillator;94;94;137;95;94;94;140;94;94;136 14:18:43 INFO - PROCESS | 7788 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 14:18:43 INFO - PROCESS | 7788 | |6;imaging-darkroom;146;145;145;146;146;147;146;148;146;146 14:18:43 INFO - PROCESS | 7788 | |7;imaging-desaturate;95;94;95;94;95;94;94;94;95;94 14:18:43 INFO - PROCESS | 7788 | |8;json-parse-financial;65;67;65;66;65;67;67;79;65;64 14:18:43 INFO - PROCESS | 7788 | |9;json-stringify-tinderbox;64;65;65;64;66;64;65;65;66;66 14:18:43 INFO - PROCESS | 7788 | |10;stanford-crypto-aes;79;79;78;85;79;79;79;79;87;79 14:18:43 INFO - PROCESS | 7788 | |11;stanford-crypto-ccm;132;130;139;132;130;129;129;131;165;131 14:18:43 INFO - PROCESS | 7788 | |12;stanford-crypto-pbkdf2;171;169;171;169;175;171;167;173;169;171 14:18:43 INFO - PROCESS | 7788 | |13;stanford-crypto-sha256-iterative;72;73;72;72;71;72;71;70;75;72 14:18:43 INFO - PROCESS | 7788 | __end_tp_report 14:18:43 INFO - PROCESS | 7788 | __start_cc_report 14:18:43 INFO - PROCESS | 7788 | _x_x_mozilla_cycle_collect,1926 14:18:43 INFO - PROCESS | 7788 | __end_cc_report 14:18:43 INFO - PROCESS | 7788 | __startTimestamp1461359923388__endTimestamp 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | ------- Summary: start ------- 14:18:43 INFO - PROCESS | 7788 | Number of tests: 14 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#0] ai-astar Cycles:10 Average:113.00 Median:115.00 stddev:4.14 (3.6%) stddev-sans-first:4.39 14:18:43 INFO - PROCESS | 7788 | Values: 113.0 114.0 109.0 113.0 117.0 115.0 103.0 115.0 116.0 115.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#1] audio-beat-detection Cycles:10 Average:160.20 Median:164.50 stddev:21.97 (13.4%) stddev-sans-first:23.30 14:18:43 INFO - PROCESS | 7788 | Values: 161.0 138.0 166.0 191.0 142.0 164.0 165.0 140.0 199.0 136.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 14:18:43 INFO - PROCESS | 7788 | Values: 160.0 160.0 161.0 162.0 162.0 162.0 161.0 162.0 160.0 162.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#3] audio-fft Cycles:10 Average:90.40 Median:74.50 stddev:19.86 (26.7%) stddev-sans-first:20.16 14:18:43 INFO - PROCESS | 7788 | Values: 74.0 74.0 117.0 110.0 75.0 77.0 76.0 120.0 105.0 76.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:94.00 stddev:21.05 (22.4%) stddev-sans-first:21.78 14:18:43 INFO - PROCESS | 7788 | Values: 94.0 94.0 137.0 95.0 94.0 94.0 140.0 94.0 94.0 136.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 14:18:43 INFO - PROCESS | 7788 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 14:18:43 INFO - PROCESS | 7788 | Values: 146.0 145.0 145.0 146.0 146.0 147.0 146.0 148.0 146.0 146.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:18:43 INFO - PROCESS | 7788 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:66.50 stddev:4.35 (6.5%) stddev-sans-first:4.55 14:18:43 INFO - PROCESS | 7788 | Values: 65.0 67.0 65.0 66.0 65.0 67.0 67.0 79.0 65.0 64.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 14:18:43 INFO - PROCESS | 7788 | Values: 64.0 65.0 65.0 64.0 66.0 64.0 65.0 65.0 66.0 66.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.00 stddev:3.06 (3.9%) stddev-sans-first:3.21 14:18:43 INFO - PROCESS | 7788 | Values: 79.0 79.0 78.0 85.0 79.0 79.0 79.0 79.0 87.0 79.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:131.50 stddev:10.99 (8.4%) stddev-sans-first:11.61 14:18:43 INFO - PROCESS | 7788 | Values: 132.0 130.0 139.0 132.0 130.0 129.0 129.0 131.0 165.0 131.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.00 stddev:2.27 (1.3%) stddev-sans-first:2.40 14:18:43 INFO - PROCESS | 7788 | Values: 171.0 169.0 171.0 169.0 175.0 171.0 167.0 173.0 169.0 171.0 14:18:43 INFO - PROCESS | 7788 | 14:18:43 INFO - PROCESS | 7788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.33 (1.9%) stddev-sans-first:1.41 14:18:43 INFO - PROCESS | 7788 | Values: 72.0 73.0 72.0 72.0 71.0 72.0 71.0 70.0 75.0 72.0 14:18:43 INFO - PROCESS | 7788 | -------- Summary: end -------- 14:18:43 INFO - PROCESS | 7788 | 14:18:44 INFO - TEST-INFO | 7788: exit 0 14:18:44 INFO - TEST-OK | kraken | took 63455ms 14:18:44 INFO - SUITE-END | took 1181s 14:18:44 INFO - Completed test suite (00:19:41) 14:18:44 INFO - javascript benchmark 14:18:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2546.427053912869, 2575.0472325239666, 2579.045753071364, 2588.702299235588, 2599.350162459385, 4530.796114174862, 4604.240300350442, 4608.769561521919, 4608.884777880555, 4641.698289611177, 4641.605463535603, 4657.254839225725, 4671.532846715327, 4719.85840424787, 4726.550977657125, 4238.957610423902, 4246.936295955563, 4266.2534056540135, 4291.635211007068, 4387.934180987288, 4309.0735491869245, 4326.06989497258, 4344.847930322439, 4352.608265256126, 4399.64802815774, 4111.753294802322, 4244.830206791725, 4254.574542545752, 4259.829606815723, 4261.6803739719335, 4266.360045993126, 4274.700770946035, 4276.23027854986, 4276.2516559601945, 4277.97861010696, 4217.746935183868, 4217.894552636178, 4251.638610718092, 4251.851185208503, 4256.404103425523, 4470.128324976631, 4489.0, 4493.4832494263255, 4497.190505709003, 4513.368128462018, 4828.37231159947, 4911.950880491221, 4914.459409464956, 4918.754062296871, 4971.229459433794, 4918.188498897677, 4962.60299176065, 4978.079055374767, 4995.250712393134, 5020.1214787412055, 4637.211674015425, 4649.209634362167, 4687.81248750053, 4687.9765601171775, 4722.055588882237, 4933.333999909966, 5042.596592272683, 5111.412187598474, 5121.897562048738, 5121.948780512222, 4862.17343051682, 4889.339939108246, 4892.363992681, 4927.285543596158, 4934.925976110361, 4979.253112033224, 4985.227289770091, 4985.576226020757, 4987.975060124676, 5033.47148549397, 4762.3808904842845, 4878.195097808822, 4936.950630493721, 4956.207006878882, 5001.9245862139815, 4915.311856340115, 4937.456879743226, 4938.061768264019, 4939.185034469344, 4963.329950456714, 4281.700280980302, 4282.807273672693, 4288.013756835945, 4330.826766929351, 4332.241857674957, 3658.5975542690285, 3696.759710618855, 3723.739338246297, 3725.2177042820767, 3769.095417099931, 4279.33670281107, 4295.570442955679, 4296.484421869396, 4316.266234740102, 4341.45731783527, 5003.0, 5022.472640372781, 5027.245913113063, 5029.823956161516, 5075.771590278372, 4179.03882107111, 4216.683748718859, 4278.422412974209, 4278.679099067583, 4290.313549832074, 4485.506594274627, 4492.932606010912, 4493.707908985905, 4520.095980803852, 4525.52481989393, 4731.858044258678, 4732.763361831963, 4737.957649317144, 4741.786619602195, 4794.041191761662, 4834.347363106076, 4944.975275123601, 4999.425066117443, 5055.393352797688, 5065.898682026413, 4669.066186762593, 4670.439547254351, 4683.742394168354, 4684.320773487893, 4712.835050773207, 4864.27035944597, 4870.707757534559, 4876.195427754381, 4877.561019508261, 4923.261510773413, 4786.688865223749, 4915.606751459946, 5013.674111182761, 5016.673916195436, 5056.772445240046, 4825.324454576432, 4827.300041493893, 4828.275758636232, 4836.606511850111, 4895.46149923501, 4751.738654373904, 4799.880002999813, 4834.8791280216865, 4835.661503694708, 4891.461939186615, 4783.258594917794, 4831.613470922388, 4834.8791280218275, 4868.075065737498, 4885.682430641997, 4841.782119804547, 4901.3383193268455, 4901.338319326987, 4907.631927605373, 4948.777305021211, 4682.0, 4747.145513807548, 4781.6891902026255, 4809.9038019240115, 4811.350467686958], "value": 4563.9239769011965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.67243834795, 588.3880764005435, 606.2906399512569, 615.4922189193915, 617.8455386153462, 27182.184534463948, 34417.0, 35398.82300588494, 35415.468767968436, 35461.93614191575, 37164.628353716456, 38103.42844857329, 38205.61794382055, 38231.42652860202, 38266.23467530648, 7360.411167106646, 7530.435217358692, 7779.0, 9568.425894446356, 9893.604255829758, 9752.171065459444, 9886.357386769872, 9904.356216845918, 9904.405735655884, 9908.702738917807, 9854.113129818315, 9891.50542472877, 9985.25110616703, 9990.600375984952, 9997.750056248615, 7431.962840185792, 9881.16010139139, 10267.075963163277, 10275.075243228071, 10282.640107596199, 9786.90213097867, 9889.703308900744, 9916.851247231298, 9917.90082099177, 9939.155171810406, 35101.0, 35406.46890296647, 35641.82179089114, 35701.28597428063, 35756.82121589375, 3188.5536024956523, 3220.4686226772556, 3428.674275943781, 3748.9250214995545, 3760.492333534965, 28812.0, 29215.269618259714, 29489.557656635166, 29540.409191816045, 29616.259593510335, 3327.2846338037198, 3413.607435144965, 3413.6586341365914, 3425.5889293284717, 3524.6122926478065, 244207.0, 245989.77005115038, 247914.0, 248283.0, 249313.0, 53120.734396328546, 53461.465385346426, 53839.19241211385, 53926.65183370447, 53946.0, 57766.0, 57820.63972963055, 58152.418475815546, 58155.41844581585, 58247.0, 12126.939365303293, 13052.738945221232, 13213.0, 13229.140105893086, 13318.200907945555, 9143.177114059767, 9151.130642588943, 9152.450852948845, 9159.679411220575, 10576.153907687367, 15851.682966340608, 16080.356785728674, 16101.19494025294, 16110.194490275439, 16151.192440377934, 5819.0, 6223.315435302113, 6294.0173845238605, 6327.145835312174, 6334.271558770801, 873.8121303919688, 912.1972664055588, 950.7765675066354, 965.3918031640022, 1016.7458135466134, 27871.30321741932, 27921.72078279232, 28045.57931631027, 28865.422691546053, 29368.0, 985.7880555680563, 1024.4928760263717, 1038.745507350704, 1056.0653821368144, 1066.802641511323, 13993.440262389391, 15356.232188390535, 15381.46164884246, 15388.769168462482, 15579.61050973712, 338334.0, 341377.0, 343942.0, 344296.0, 346741.0, 49340.25989610159, 49686.75156624266, 49700.0, 49792.25311620328, 49792.50207497951, 1062.2139616683753, 1189.423129782055, 1224.5407972010673, 1258.7230809221955, 1302.8827405533548, 24746.133885313928, 25773.484530309663, 25901.0, 26004.21987340383, 26167.476650467266, 35122.83894449512, 35334.82332588424, 35632.28735425329, 35672.28655426929, 35760.28479430345, 186848.0, 187771.0, 189258.0, 189378.0, 189424.0, 22906.54186916219, 23859.0, 25059.0, 25653.0, 25922.35194120162, 35713.821430892676, 36437.27125457529, 43049.569504304556, 44535.331970019826, 45386.0, 31404.214894627818, 35314.76398326046, 35576.64423355837, 35687.64312356843, 36039.63960360363, 34917.0, 35086.82456587701, 35237.82381088078, 35462.0, 35579.0, 34470.65529344675, 34598.65401346055, 34717.652823472454, 34912.30175396529, 35049.299014020085, 30656.693433065382, 30826.0, 31351.86481351938, 31416.214594635316, 31511.369772604878, 24053.0, 24347.51304973926, 24733.752662473144, 24971.50056998886, 25063.624045639695], "value": 17266.39462047717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.8244498753069, 390.23708649590054, 390.74992005116724, 392.5836476487222, 404.42773475532124, 12604.495820167182, 12907.290099044549, 15209.4676686316, 16148.919255403722, 16156.596085097879, 14188.645283867883, 15016.624584385396, 15018.624534386647, 15022.699546009073, 15026.474073407433, 5123.154679477891, 5254.21186821976, 5309.946900531003, 5316.043112239795, 5317.548008419289, 3700.296943580711, 4809.543093406139, 5214.895702085956, 5220.29526013987, 5266.3943646480575, 6087.939120608781, 6108.144859719643, 6117.082437634346, 6120.296165940907, 6127.5404344674325, 6008.188894499231, 6056.364081771417, 6068.120122582245, 6070.484008859252, 6073.0, 5171.896562068775, 5343.545798607123, 5354.27717258169, 5355.919661205085, 5384.3538775346815, 18819.90590047055, 20705.0, 20814.47963800902, 21099.15603375863, 21119.683204751942, 1980.0996013956226, 2050.149188086942, 2092.1213090502024, 2200.680901269307, 2564.025670245295, 12821.67945801353, 12945.417456214493, 13071.607851764462, 13172.143810652276, 13635.795463068062, 1730.731736580832, 1786.767720196379, 1793.3812834572182, 1828.9359872404402, 1847.131848031423, 46183.53816461859, 50481.76272874393, 57213.713931430495, 62116.68941655308, 71099.64450177767, 9323.720288391223, 9329.766755831159, 9486.430814151036, 9566.091221333962, 9712.70861874145, 12616.936915315548, 12715.745685086247, 12743.553975610994, 12750.61748147557, 12833.101682882296, 7102.644867756591, 7121.145462544528, 7189.92810071903, 7295.671694773748, 7324.414046876237, 6984.161900571964, 7145.214026457085, 7197.0, 7276.326444917699, 7283.526570772883, 5994.280686317583, 5999.880002399927, 6042.486388656926, 6063.484603808725, 6107.373829253374, 1685.5196269063258, 1785.1342099081935, 1808.1049880309067, 1825.7626508553803, 1858.135966775456, 913.7258822353267, 918.1048477734289, 984.3650845204803, 991.0535438656066, 1018.1905385218621, 16837.57906052334, 17156.142192890555, 17538.736918946226, 17660.646787064445, 17906.194221260073, 892.4957399069505, 903.4940433357209, 924.5654542365078, 932.2169377722745, 942.7737343037621, 9723.562439690231, 10142.847857282146, 10228.335158214692, 10298.897011029943, 10336.224783141295, 419481.0, 423188.0, 425664.0, 426014.0, 428471.0, 73218.63390683013, 73611.0, 75005.24994750092, 76829.61585192039, 77153.0, 879.305348774461, 943.5518128888723, 973.0415540692412, 993.0, 995.9800803983879, 15675.608109797346, 16052.438164664181, 16121.919390402973, 16202.67594648124, 16211.133710428345, 32983.34033319272, 33670.0, 33839.83080084682, 33921.3215735679, 34396.14009649779, 39531.0, 45020.0, 45219.321710175034, 45637.54362456333, 49843.25235121403, 7562.621868906643, 7894.881576776468, 7941.12647608751, 7993.920060799318, 8016.7194148204535, 8751.081136480578, 11155.72110697239, 12043.698907527032, 12087.697807554881, 12397.876021239672, 10208.846867296848, 10452.947735261276, 10507.632232871812, 10521.0, 10787.622433215114, 9873.753156171153, 10081.949590252001, 10253.0, 10277.794444111225, 10317.9484102579, 10254.282200246209, 10470.0, 10747.140228781835, 10750.301230419998, 10982.0, 7783.143854176149, 7803.648835802289, 7850.725224617111, 7980.401469889897, 8008.0, 10155.847662284923, 10611.41637209961, 10619.893801062199, 10675.199360047873, 10784.946075269574], "value": 8381.013487530003, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.0545974140168, 1254.7427777305654, 1294.760469313177, 1351.1015174908687, 1817.064211930856, 6662.333766623341, 6941.791746247614, 7540.585267810268, 7717.344025757803, 7749.535027898316, 7575.053118360205, 7621.961890190555, 7686.5003774754605, 7697.615119244029, 7706.113796913357, 1855.6103218324167, 2123.6708310211943, 2170.6635471501904, 2199.967000494994, 2200.3069033254556, 2183.050373087704, 2193.473566344082, 2202.1631779923687, 2206.6248737714627, 2212.4026512841524, 2183.5960347335713, 2205.8676479411206, 2217.4013016485537, 2219.1012639880873, 2220.811231045363, 1809.0773705410204, 2086.467950672569, 2087.9060442280133, 2170.142793596536, 2178.967315490269, 2138.8930553472264, 2161.2543672432985, 2164.751053628837, 2165.3936897668677, 2168.2844661261747, 7449.925500744977, 7492.925070749332, 7496.887546686749, 7507.136679281898, 7507.8498430031095, 4497.235469970113, 4693.225617773063, 4701.224297990828, 4702.694324868872, 4703.623710103184, 2951.335949411365, 3029.545568164771, 3108.797928134664, 3126.249700071989, 3137.278425962019, 980.7499087732654, 998.3610489286863, 1001.7746007148406, 1001.8597396364515, 1020.9744756381076, 10503.0, 10689.572417103307, 10750.731231719192, 10775.622853200179, 10820.567177312898, 4244.342126970325, 4252.659787217015, 4424.6239069678795, 4425.645948324126, 4526.660500462479, 9294.86057709135, 9317.627294908263, 9318.068193180628, 9319.301052421095, 9353.625854965861, 4839.685420447659, 4848.80604775805, 4859.611231101574, 4875.756212189376, 4880.048390563806, 3720.497732806091, 4219.156168766259, 4304.031592891574, 4306.698531102793, 4312.094460163338, 3714.1457464783252, 3730.5896351401325, 3826.0626146593704, 3861.0540417597867, 3892.3188442022533, 1211.5335595795682, 1251.7934540800848, 1261.9558315458914, 1265.3230521670862, 1274.6112435707014, 777.0946846923271, 790.9564973926489, 799.2407213147417, 808.1312588966885, 809.8258874342044, 5280.339957505312, 5451.536619387317, 5478.671279723229, 5498.725063746797, 5548.167774833726, 915.8809354783835, 922.3405265235255, 941.3081385181886, 949.3307218411004, 958.3262697075082, 3781.205946751213, 3847.5575308839284, 3850.4609354690365, 3858.6141385861188, 3907.941380879289, 9157.450552966844, 9561.235101191887, 9614.663486778069, 9617.27870409722, 9632.13310802017, 9668.129868311746, 9830.066143716336, 9866.901330986742, 9908.157806586376, 9932.0, 6979.93020069803, 7017.0, 7042.436605071582, 7048.259932707095, 7093.361597456254, 5168.0697474454955, 5207.505286997729, 5262.289590905179, 5286.9471305288, 5357.973210133924, 8335.541545214828, 8404.831903361775, 8575.099614540384, 8616.612252448529, 8679.392442528962, 8652.048274689652, 8742.781430464289, 8832.867506987528, 8880.333974951775, 8902.287816974496, 6257.530685198537, 6575.572587781779, 6672.0, 6690.160205943404, 6938.930610693828, 7450.888236676563, 7464.738734144496, 7521.924780752122, 7534.886976695244, 7543.283388078124, 6448.613083215022, 6758.628275444898, 6799.286074962058, 6848.554843935129, 6919.446444284345, 6614.801555953329, 6628.801135965929, 6636.502262330441, 6712.194536655633, 6755.256921738703, 6280.7487700491465, 6474.0, 6489.5781774184525, 6532.150820393318, 6544.181977252843, 4612.930806037845, 4682.22743247374, 4754.619630429626, 4780.95219047805, 4814.662973591815, 4568.748718820497, 4659.2079346511855, 4687.437507499122, 4754.904901902012, 4770.976145119253], "value": 4169.979488588729, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.31347230399246, 322.54199037366936, 322.6724874252634, 329.8120071559209, 333.12056171706683, 5130.974345128278, 5141.691498510092, 5157.406898206707, 5177.482251774821, 5181.274621552986, 5094.974525127369, 5100.617453690969, 5101.668391554546, 5101.693898366091, 5118.692878427288, 3813.6949044076478, 3878.3019056569806, 4000.4999375078114, 4031.919361612766, 4074.8777536673947, 4025.0339918419513, 4040.9595904041025, 4049.1699201663737, 4053.0, 4059.7361171523758, 3772.830222639988, 3982.26328129297, 3999.1002024544537, 4006.8597599084037, 4013.357862741962, 3890.396988466792, 3963.929738970476, 3986.720929534934, 4022.3363145081025, 4027.7180597358197, 3560.964390356089, 3572.3034008368377, 3577.910552236189, 3579.552555930509, 3588.7308451866215, 4916.877078073041, 4919.311296418504, 4919.606431485508, 4922.114019476493, 4926.433460152092, 4318.892027699301, 4506.504284528699, 4541.6593755468475, 4572.0, 4635.907281854344, 5301.893962120775, 5318.590573498026, 5366.9463305366835, 5377.81177658784, 5378.569714422837, 3802.8098595070414, 3809.8095095245403, 3812.90467738306, 3821.8280177392085, 3829.2341531693496, 5511.889762204773, 5578.832635020955, 5613.578981576398, 5630.943690563083, 5663.065594176997, 3873.8837834865, 3914.530256369254, 3919.6080391960577, 3922.764634121962, 3928.4303775952326, 3942.3889297158985, 3959.604039596017, 3971.543272523639, 3972.66232370246, 3982.2234664240773, 4441.133978874153, 4495.201919232333, 4521.231390663529, 4538.797218737037, 4540.137373898949, 5361.329833770778, 5397.217403476552, 5403.378611459654, 5413.431589683105, 5432.185172224198, 1368.637311112556, 1370.2460850111872, 1378.5864240727742, 1386.6671998720235, 1387.7502049631164, 871.3551971541013, 908.1100521488846, 931.0, 935.9298052646079, 945.4752612300102, 4653.790579423934, 4662.953370466252, 4668.50980647034, 4673.6728429009645, 4680.438347398334, 5490.6980116094, 5504.4770746778995, 5505.174223866452, 5505.3393592768325, 5513.862153446196, 4554.840580579664, 4652.744099074584, 4673.322368256584, 4692.906141877212, 4781.95218047822, 2971.301744090137, 2995.8651860666323, 2996.5055765798834, 3004.173852190665, 3004.7596192304563, 5302.814401496006, 5304.549113325334, 5309.522143007148, 5312.840614781563, 5325.866853328698, 5559.6664200148125, 5716.0, 5754.395788442237, 5762.279715035621, 5787.160861675034, 5271.156614941591, 5287.814926477555, 5294.338207724035, 5299.231611416323, 5303.7348132593215, 5386.016059541646, 5535.7785688572, 5563.610547261653, 5616.213730077874, 5626.521745651666, 5465.699386533779, 5481.150421684645, 5501.174823776466, 5504.504594586507, 5511.917321240105, 5215.76529056201, 5243.0, 5255.316808814982, 5256.500632439912, 5276.0, 3802.9239415210986, 3866.226754649025, 3866.5940076291586, 3876.825542850522, 3880.611938806097, 5539.169124631338, 5547.805826796042, 5571.860703482445, 5571.8885622288135, 5579.716665167116, 5355.732213389393, 5368.32895888014, 5396.541293990055, 5399.379071406838, 5406.702631355156, 5267.104592219409, 5329.7868085277705, 5367.758450869798, 5370.301860758076, 5403.9459605403445, 5053.140966035856, 5287.524122828964, 5301.363836339664, 5317.760700768397, 5320.680759154463, 5203.49098761355, 5418.566514678895, 5467.753951072132, 5468.28912241406, 5476.2607048048, 5319.627626066138, 5323.361196656426, 5328.70692111922, 5331.306930099217, 5336.813211537577], "value": 4060.9234588097033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.3701109923372, 676.1750664189689, 696.188939885034, 704.6899364279719, 741.1921006103348, 12492.812607810878, 12757.553485627981, 12888.16226945248, 12906.612801615955, 12917.547885823999, 12073.698157546043, 12275.44760485778, 12360.814587781191, 12421.875781242185, 12444.315562644051, 812.6749300279877, 828.2711214131585, 828.6022709099636, 828.6975254032295, 828.888100106484, 648.2933602373412, 788.1055002572065, 798.7084714079348, 827.983440331193, 829.6473998550622, 854.9273311768507, 859.7807559072428, 860.9397342186049, 861.4529773593782, 861.8664107063415, 850.3877208409966, 851.4252879306474, 851.748734123435, 852.3266619370689, 852.5737131434283, 497.9502049794992, 595.752762603519, 623.4139908486054, 623.5323507369473, 624.2446639566085, 12351.258924464471, 12379.566715164927, 12389.0, 12418.192817466836, 12424.192427492184, 11646.941765291203, 12440.626781196579, 12452.128351015432, 12572.622821315375, 12602.117851750381, 11275.32348059119, 11287.887121128766, 11373.31760094397, 11421.54313827446, 11464.25482343645, 4188.958110418887, 4237.957620423787, 4253.0, 4397.780110994469, 4415.492218394894, 42863.142737145085, 44233.33649995253, 44281.0, 44281.11437771226, 44307.33538996918, 10241.180705543538, 10262.58949642006, 10372.481375931173, 10528.315659482108, 10568.0, 17504.474865754048, 17697.203625836868, 17707.114644267735, 17768.555786105193, 17775.822241777416, 7030.0, 7169.533980291264, 7184.544274007684, 7282.781516554512, 7297.124345078624, 3895.3767397216875, 3942.8619998299923, 3967.1867267210155, 3997.960020399817, 4016.859409920697, 2822.5766135079903, 2890.0173940859786, 2893.160983314815, 2896.5799959005826, 2901.448724742292, 530.8911673107003, 533.6051322021754, 537.532346858228, 537.967721936685, 545.929029226198, 589.4105894105894, 595.5087053181143, 597.357840321656, 601.0653433910311, 611.3794498583941, 7802.180771019075, 8305.335573154132, 8327.125651806595, 8518.063013068557, 8525.40322177454, 606.3633185155569, 616.2836500346514, 649.5226008883467, 649.9252585952676, 679.0323788601223, 3833.8274777635074, 3903.9609603904164, 3963.742356746802, 3979.522457305142, 4057.8173982170874, 45263.77368113138, 54267.85982102637, 54467.72766136144, 54558.45441545613, 54628.45371546313, 41308.586914131076, 41637.375439368436, 41689.1662166761, 41706.582934170874, 42373.1525369497, 38605.613943860204, 38607.80696096501, 38973.0, 38986.22027559433, 39289.999999999425, 7780.2219778021745, 8421.15788421153, 8626.827463450822, 8646.610902509528, 8728.258098061737, 26666.0, 26731.465370692087, 27751.167464976083, 28384.57423138696, 28746.0, 34372.65627343694, 37100.81449592735, 37404.62595374011, 37678.0, 37737.81131094327, 10701.51843167075, 10977.231593788678, 11013.394263315595, 11016.559337626406, 11031.22781405294, 11200.943995279971, 11296.6046188383, 11767.823482647596, 11958.039879944146, 12129.45417456199, 8001.679932802856, 10441.425721585081, 10453.0, 11257.380844053656, 11727.120465964916, 10952.178586606196, 11494.712632184262, 11532.654020379403, 11868.58459953932, 12023.579174728842, 10963.451827408438, 11083.667489975314, 11331.490082946122, 11459.770804584028, 11478.94260528692, 9142.131497507726, 9378.859317110113, 9444.338896277195, 9645.08371704687, 9710.854337185088, 9649.118456617267, 10008.665942844691, 10071.348253112226, 10117.08946194846, 10146.391216527032], "value": 6030.806847365021, "unit": "score"}], "name": "dromaeo_css", "value": 6380.228885387109, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 109.0, 113.0, 117.0, 115.0, 103.0, 115.0, 116.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 138.0, 166.0, 191.0, 142.0, 164.0, 165.0, 140.0, 199.0, 136.0], "value": 160.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 117.0, 110.0, 75.0, 77.0, 76.0, 120.0, 105.0, 76.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 137.0, 95.0, 94.0, 94.0, 140.0, 94.0, 94.0, 136.0], "value": 107.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 66.0, 65.0, 67.0, 67.0, 79.0, 65.0, 64.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 66.0, 64.0, 65.0, 65.0, 66.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 85.0, 79.0, 79.0, 79.0, 79.0, 87.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 139.0, 132.0, 130.0, 129.0, 129.0, 131.0, 165.0, 131.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 171.0, 169.0, 175.0, 171.0, 167.0, 173.0, 169.0, 171.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 71.0, 72.0, 71.0, 70.0, 75.0, 72.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1579.2999999999997, "alertThreshold": 2.0}]} 14:18:44 INFO - Return code: 0 14:18:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:18:44 ERROR - # TBPL SUCCESS # 14:18:44 INFO - Running post-action listener: _resource_record_post_action 14:18:44 INFO - Running post-run listener: _resource_record_post_run 14:18:45 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 529793024; Read time: 0; Write time: 526708 14:18:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241762304; Read time: 0; Write time: 339456 14:18:45 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288030720; Read time: 0; Write time: 187252 14:18:45 INFO - Running post-run listener: _upload_blobber_files 14:18:45 INFO - Blob upload gear active. 14:18:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:18:45 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 14:18:45 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:18:45 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:18:46 INFO - (blobuploader) - INFO - Open directory for files ... 14:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:47 INFO - (blobuploader) - INFO - Done attempting. 14:18:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:18:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:48 INFO - (blobuploader) - INFO - Done attempting. 14:18:48 INFO - (blobuploader) - INFO - Iteration through files over. 14:18:48 INFO - Return code: 0 14:18:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:18:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:18:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fbac3b940228bbed9b45fe6ab6839e42163cce389ca38821f8d402153f01e1b29ebaf87da8159536c6491ad10381bcec5f46957a9f8279fe84904a919be7a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a12ce7156eeaa48ca32697956e76fa1a2389a67f9130038c459cd281c9eaf718f4d7a96754aa157cfdc0d413c6283460a3a4352ebf856e4a46d265c948db57e6"} 14:18:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:18:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:18:48 INFO - Contents: 14:18:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fbac3b940228bbed9b45fe6ab6839e42163cce389ca38821f8d402153f01e1b29ebaf87da8159536c6491ad10381bcec5f46957a9f8279fe84904a919be7a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a12ce7156eeaa48ca32697956e76fa1a2389a67f9130038c459cd281c9eaf718f4d7a96754aa157cfdc0d413c6283460a3a4352ebf856e4a46d265c948db57e6"} 14:18:48 INFO - Running post-run listener: copy_logs_to_upload_dir 14:18:48 INFO - Copying logs to upload dir... 14:18:48 INFO - mkdir: /builds/slave/test/build/upload/logs 14:18:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.568471 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-22 14:18:48.242045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 14:18:48.245051) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fbac3b940228bbed9b45fe6ab6839e42163cce389ca38821f8d402153f01e1b29ebaf87da8159536c6491ad10381bcec5f46957a9f8279fe84904a919be7a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a12ce7156eeaa48ca32697956e76fa1a2389a67f9130038c459cd281c9eaf718f4d7a96754aa157cfdc0d413c6283460a3a4352ebf856e4a46d265c948db57e6"} build_url:https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011517 build_url: 'https://queue.taskcluster.net/v1/task/PiQ_TdpDSyGZ6cBHnv46Ww/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fbac3b940228bbed9b45fe6ab6839e42163cce389ca38821f8d402153f01e1b29ebaf87da8159536c6491ad10381bcec5f46957a9f8279fe84904a919be7a1ef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a12ce7156eeaa48ca32697956e76fa1a2389a67f9130038c459cd281c9eaf718f4d7a96754aa157cfdc0d413c6283460a3a4352ebf856e4a46d265c948db57e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 14:18:48.269171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 14:18:48.269460) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1461358682.492923-1166104633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 14:18:48.354109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 14:18:48.354387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 14:18:48.354669) ========= ========= Total master_lag: 0.16 =========