builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1469792640.22 results: success (0) buildid: 20160729033626 builduid: 556fbeb7fb1a4409a2e5e53a1d208458 revision: 0d59012b60b0a9f305e0e506ae954dbc28b55ffa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.219580) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.220049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.220345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.235627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.235997) ========= 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=fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 04:44:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.8M=0s 2016-07-29 04:44:00 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.353040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.353354) ========= 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=fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.404004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:00.404356) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d59012b60b0a9f305e0e506ae954dbc28b55ffa --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 0d59012b60b0a9f305e0e506ae954dbc28b55ffa --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=fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 04:44:00,743 truncating revision to first 12 chars 2016-07-29 04:44:00,743 Setting DEBUG logging. 2016-07-29 04:44:00,743 attempt 1/10 2016-07-29 04:44:00,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d59012b60b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 04:44:01,068 unpacking tar archive at: fx-team-0d59012b60b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:01.081269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:01.081605) ========= script_repo_revision: 0d59012b60b0a9f305e0e506ae954dbc28b55ffa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:01.082006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:01.082283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 04:44:01.091145) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-29 04:44:01.091492) ========= /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=fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:44:01 INFO - MultiFileLogger online at 20160729 04:44:01 in /builds/slave/test 04:44:01 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 04:44:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:01 INFO - {'append_to_log': False, 04:44:01 INFO - 'base_work_dir': '/builds/slave/test', 04:44:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:44:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:01 INFO - 'branch': 'Fx-Team-Non-PGO', 04:44:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:01 INFO - 'config_files': ('talos/linux_config.py',), 04:44:01 INFO - 'default_actions': ('clobber', 04:44:01 INFO - 'read-buildbot-config', 04:44:01 INFO - 'download-and-extract', 04:44:01 INFO - 'populate-webroot', 04:44:01 INFO - 'create-virtualenv', 04:44:01 INFO - 'install', 04:44:01 INFO - 'run-tests'), 04:44:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:01 INFO - 'download_minidump_stackwalk': True, 04:44:01 INFO - 'download_symbols': 'ondemand', 04:44:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:01 INFO - 'installer_path': 'installer.exe', 04:44:01 INFO - 'log_level': 'info', 04:44:01 INFO - 'log_name': 'talos', 04:44:01 INFO - 'log_to_console': True, 04:44:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:44:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:44:01 INFO - 'opt_config_files': (), 04:44:01 INFO - 'pip_index': False, 04:44:01 INFO - 'sps_profile': False, 04:44:01 INFO - 'sps_profile_interval': 0, 04:44:01 INFO - 'suite': 'dromaeojs', 04:44:01 INFO - 'system_bits': '32', 04:44:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:01 INFO - 'title': 'talos-linux64-ix-048', 04:44:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:01 INFO - 'use_talos_json': True, 04:44:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:01 INFO - 'work_dir': 'build'} 04:44:01 INFO - [mozharness: 2016-07-29 11:44:01.516827Z] Running clobber step. 04:44:01 INFO - Running pre-action listener: _resource_record_pre_action 04:44:01 INFO - Running main action method: clobber 04:44:01 INFO - rmtree: /builds/slave/test/build 04:44:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:01 INFO - Running post-action listener: _resource_record_post_action 04:44:01 INFO - [mozharness: 2016-07-29 11:44:01.991886Z] Finished clobber step (success) 04:44:01 INFO - [mozharness: 2016-07-29 11:44:01.991988Z] Running read-buildbot-config step. 04:44:01 INFO - Running pre-action listener: _resource_record_pre_action 04:44:01 INFO - Running main action method: read_buildbot_config 04:44:01 INFO - Using buildbot properties: 04:44:01 INFO - { 04:44:01 INFO - "project": "", 04:44:01 INFO - "product": "firefox", 04:44:01 INFO - "script_repo_revision": "production", 04:44:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:44:01 INFO - "repository": "", 04:44:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:44:01 INFO - "buildid": "20160729033626", 04:44:01 INFO - "pgo_build": "False", 04:44:01 INFO - "basedir": "/builds/slave/test", 04:44:01 INFO - "buildnumber": 2039, 04:44:01 INFO - "slavename": "talos-linux64-ix-048", 04:44:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:44:01 INFO - "platform": "ubuntu64_hw", 04:44:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:44:01 INFO - "branch": "fx-team", 04:44:01 INFO - "repo_path": "integration/fx-team", 04:44:01 INFO - "revision": "0d59012b60b0a9f305e0e506ae954dbc28b55ffa", 04:44:01 INFO - "stage_platform": "linux64", 04:44:01 INFO - "builduid": "556fbeb7fb1a4409a2e5e53a1d208458", 04:44:01 INFO - "slavebuilddir": "test" 04:44:01 INFO - } 04:44:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:44:01 INFO - Running post-action listener: _resource_record_post_action 04:44:01 INFO - [mozharness: 2016-07-29 11:44:01.994425Z] Finished read-buildbot-config step (success) 04:44:01 INFO - [mozharness: 2016-07-29 11:44:01.994516Z] Running download-and-extract step. 04:44:01 INFO - Running pre-action listener: _resource_record_pre_action 04:44:01 INFO - Running main action method: download_and_extract 04:44:01 INFO - mkdir: /builds/slave/test/build/tests 04:44: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')]} 04:44:01 INFO - https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:44:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:44:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:44:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:44:02 INFO - Downloaded 1361 bytes. 04:44:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:44:02 INFO - Using the following test package requirements: 04:44:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:44:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:44:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'jsshell-linux-x86_64.zip'], 04:44:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:44:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:44:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:44:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:44:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:44:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:02 INFO - https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:44:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:44:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:44:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:07 INFO - Downloaded 22758364 bytes. 04:44:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:44:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:44:08 INFO - Return code: 0 04:44:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:08 INFO - https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:44:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:44:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:10 INFO - Downloaded 22758364 bytes. 04:44:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:44:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:44:12 INFO - Return code: 0 04:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:12 INFO - https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:44:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:44:13 INFO - Downloaded 14413725 bytes. 04:44:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:44:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:44:14 INFO - Return code: 0 04:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:14 INFO - https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:44:15 INFO - Downloaded 57172981 bytes. 04:44:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:44:15 INFO - mkdir: /builds/slave/test/properties 04:44:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:15 INFO - Contents: 04:44:15 INFO - build_url:https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:44:15 INFO - Running post-action listener: _resource_record_post_action 04:44:15 INFO - Running post-action listener: set_extra_try_arguments 04:44:15 INFO - [mozharness: 2016-07-29 11:44:15.921183Z] Finished download-and-extract step (success) 04:44:15 INFO - [mozharness: 2016-07-29 11:44:15.921415Z] Running populate-webroot step. 04:44:15 INFO - Running pre-action listener: _resource_record_pre_action 04:44:15 INFO - Running main action method: populate_webroot 04:44:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:15 INFO - '--tppagecycles', 04:44:15 INFO - '7'], 04:44:15 INFO - 'tests': ['tsvgm']}}, 04:44:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['damp', 'tps']}, 04:44:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'tests': ['damp', 'tps']}, 04:44:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['dromaeo_dom']}, 04:44:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['basic_compositor_video']}, 04:44:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['a11yr', 04:44:15 INFO - 'ts_paint', 04:44:15 INFO - 'tpaint', 04:44:15 INFO - 'sessionrestore', 04:44:15 INFO - 'sessionrestore_no_auto_restore', 04:44:15 INFO - 'tabpaint']}, 04:44:15 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:15 INFO - 'ts_paint', 04:44:15 INFO - 'tpaint', 04:44:15 INFO - 'sessionrestore', 04:44:15 INFO - 'sessionrestore_no_auto_restore', 04:44:15 INFO - 'tabpaint']}, 04:44:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:15 INFO - 'ts_paint', 04:44:15 INFO - 'tpaint', 04:44:15 INFO - 'sessionrestore', 04:44:15 INFO - 'sessionrestore_no_auto_restore', 04:44:15 INFO - 'tabpaint']}, 04:44:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:15 INFO - 'ts_paint', 04:44:15 INFO - 'tpaint', 04:44:15 INFO - 'sessionrestore', 04:44:15 INFO - 'sessionrestore_no_auto_restore', 04:44:15 INFO - 'tabpaint']}, 04:44:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['a11yr', 04:44:15 INFO - 'ts_paint', 04:44:15 INFO - 'tpaint', 04:44:15 INFO - 'sessionrestore', 04:44:15 INFO - 'sessionrestore_no_auto_restore', 04:44:15 INFO - 'tabpaint']}, 04:44:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['a11yr', 04:44:15 INFO - 'ts_paint', 04:44:15 INFO - 'tpaint', 04:44:15 INFO - 'sessionrestore', 04:44:15 INFO - 'sessionrestore_no_auto_restore', 04:44:15 INFO - 'tabpaint']}, 04:44:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['tsvgx', 04:44:15 INFO - 'tsvgr_opacity', 04:44:15 INFO - 'tart', 04:44:15 INFO - 'tscrollx', 04:44:15 INFO - 'cart']}, 04:44:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:15 INFO - 'tsvgr_opacity', 04:44:15 INFO - 'tart', 04:44:15 INFO - 'tscrollx', 04:44:15 INFO - 'cart']}, 04:44:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'talos_options': ['--disable-e10s'], 04:44:15 INFO - 'tests': ['tp5o']}, 04:44:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'tests': ['tp5o']}, 04:44:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'talos_options': ['--disable-e10s', 04:44:15 INFO - '--xperf_path', 04:44:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:15 INFO - 'tests': ['tp5n']}, 04:44:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:15 INFO - 'talos_options': ['--xperf_path', 04:44:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:15 INFO - 'tests': ['tp5n']}}, 04:44:15 INFO - 'talos.zip': {'path': '', 04:44:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:15 INFO - Running post-action listener: _resource_record_post_action 04:44:15 INFO - [mozharness: 2016-07-29 11:44:15.938129Z] Finished populate-webroot step (success) 04:44:15 INFO - [mozharness: 2016-07-29 11:44:15.938219Z] Running create-virtualenv step. 04:44:15 INFO - Running pre-action listener: _resource_record_pre_action 04:44:15 INFO - Running main action method: create_virtualenv 04:44:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:44:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:16 INFO - Using real prefix '/usr' 04:44:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:18 INFO - Installing pip.................done. 04:44:18 INFO - Return code: 0 04:44:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:44:18 INFO - Using env: {'DISPLAY': ':0', 04:44:18 INFO - 'HOME': '/home/cltbld', 04:44:18 INFO - 'LANG': 'en_US.UTF-8', 04:44:18 INFO - 'LANGUAGE': 'en_US:en', 04:44:18 INFO - 'LOGNAME': 'cltbld', 04:44:18 INFO - 'MAIL': '/var/mail/cltbld', 04:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:18 INFO - 'MOZ_NO_REMOTE': '1', 04:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:18 INFO - 'NO_EM_RESTART': '1', 04:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:18 INFO - 'PWD': '/builds/slave/test', 04:44:18 INFO - 'SHELL': '/bin/bash', 04:44:18 INFO - 'SHLVL': '1', 04:44:18 INFO - 'TERM': 'linux', 04:44:18 INFO - 'TMOUT': '86400', 04:44:18 INFO - 'USER': 'cltbld', 04:44:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:18 INFO - '_': '/tools/buildbot/bin/python'} 04:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:44:18 INFO - Cleaning up... 04:44:18 INFO - Return code: 0 04:44:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44: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')]} 04:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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')]} 04:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:44:18 INFO - Using env: {'DISPLAY': ':0', 04:44:18 INFO - 'HOME': '/home/cltbld', 04:44:18 INFO - 'LANG': 'en_US.UTF-8', 04:44:18 INFO - 'LANGUAGE': 'en_US:en', 04:44:18 INFO - 'LOGNAME': 'cltbld', 04:44:18 INFO - 'MAIL': '/var/mail/cltbld', 04:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:18 INFO - 'MOZ_NO_REMOTE': '1', 04:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:18 INFO - 'NO_EM_RESTART': '1', 04:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:18 INFO - 'PWD': '/builds/slave/test', 04:44:18 INFO - 'SHELL': '/bin/bash', 04:44:18 INFO - 'SHLVL': '1', 04:44:18 INFO - 'TERM': 'linux', 04:44:18 INFO - 'TMOUT': '86400', 04:44:18 INFO - 'USER': 'cltbld', 04:44:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:18 INFO - '_': '/tools/buildbot/bin/python'} 04:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:19 INFO - Downloading/unpacking psutil>=3.1.1 04:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:21 INFO - Installing collected packages: psutil 04:44:21 INFO - Running setup.py install for psutil 04:44:21 INFO - building 'psutil._psutil_linux' extension 04:44:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:44:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:44:21 INFO - building 'psutil._psutil_posix' extension 04:44:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:44:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:44:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:21 INFO - Successfully installed psutil 04:44:21 INFO - Cleaning up... 04:44:21 INFO - Return code: 0 04:44:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:21 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:21 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.3'] in /builds/slave/test/build 04:44:21 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.3 04:44:21 INFO - Using env: {'DISPLAY': ':0', 04:44:21 INFO - 'HOME': '/home/cltbld', 04:44:21 INFO - 'LANG': 'en_US.UTF-8', 04:44:21 INFO - 'LANGUAGE': 'en_US:en', 04:44:21 INFO - 'LOGNAME': 'cltbld', 04:44:21 INFO - 'MAIL': '/var/mail/cltbld', 04:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:21 INFO - 'MOZ_NO_REMOTE': '1', 04:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:21 INFO - 'NO_EM_RESTART': '1', 04:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:21 INFO - 'PWD': '/builds/slave/test', 04:44:21 INFO - 'SHELL': '/bin/bash', 04:44:21 INFO - 'SHLVL': '1', 04:44:21 INFO - 'TERM': 'linux', 04:44:21 INFO - 'TMOUT': '86400', 04:44:21 INFO - 'USER': 'cltbld', 04:44:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:21 INFO - '_': '/tools/buildbot/bin/python'} 04:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:23 INFO - Installing collected packages: mozsystemmonitor 04:44:23 INFO - Running setup.py install for mozsystemmonitor 04:44:23 INFO - Successfully installed mozsystemmonitor 04:44:23 INFO - Cleaning up... 04:44:23 INFO - Return code: 0 04:44:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:23 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:23 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==2.5.1'] in /builds/slave/test/build 04:44:23 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==2.5.1 04:44:23 INFO - Using env: {'DISPLAY': ':0', 04:44:23 INFO - 'HOME': '/home/cltbld', 04:44:23 INFO - 'LANG': 'en_US.UTF-8', 04:44:23 INFO - 'LANGUAGE': 'en_US:en', 04:44:23 INFO - 'LOGNAME': 'cltbld', 04:44:23 INFO - 'MAIL': '/var/mail/cltbld', 04:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:23 INFO - 'MOZ_NO_REMOTE': '1', 04:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:23 INFO - 'NO_EM_RESTART': '1', 04:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:23 INFO - 'PWD': '/builds/slave/test', 04:44:23 INFO - 'SHELL': '/bin/bash', 04:44:23 INFO - 'SHLVL': '1', 04:44:23 INFO - 'TERM': 'linux', 04:44:23 INFO - 'TMOUT': '86400', 04:44:23 INFO - 'USER': 'cltbld', 04:44:23 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:23 INFO - '_': '/tools/buildbot/bin/python'} 04:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:24 INFO - Downloading/unpacking jsonschema==2.5.1 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:26 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:26 INFO - warning: no files found matching '*.txt' 04:44:26 INFO - no previously-included directories found matching 'build' 04:44:26 INFO - no previously-included directories found matching 'dist' 04:44:26 INFO - no previously-included directories found matching '.git*' 04:44:26 INFO - Installing collected packages: jsonschema, functools32 04:44:26 INFO - Running setup.py install for functools32 04:44:26 INFO - warning: no files found matching '*.txt' 04:44:26 INFO - no previously-included directories found matching 'build' 04:44:26 INFO - no previously-included directories found matching 'dist' 04:44:26 INFO - no previously-included directories found matching '.git*' 04:44:26 INFO - Successfully installed jsonschema functools32 04:44:26 INFO - Cleaning up... 04:44:26 INFO - Return code: 0 04:44:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:26 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:26 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:44:26 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 functools32==3.2.3-2 04:44:26 INFO - Using env: {'DISPLAY': ':0', 04:44:26 INFO - 'HOME': '/home/cltbld', 04:44:26 INFO - 'LANG': 'en_US.UTF-8', 04:44:26 INFO - 'LANGUAGE': 'en_US:en', 04:44:26 INFO - 'LOGNAME': 'cltbld', 04:44:26 INFO - 'MAIL': '/var/mail/cltbld', 04:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:26 INFO - 'MOZ_NO_REMOTE': '1', 04:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:26 INFO - 'NO_EM_RESTART': '1', 04:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:26 INFO - 'PWD': '/builds/slave/test', 04:44:26 INFO - 'SHELL': '/bin/bash', 04:44:26 INFO - 'SHLVL': '1', 04:44:26 INFO - 'TERM': 'linux', 04:44:26 INFO - 'TMOUT': '86400', 04:44:26 INFO - 'USER': 'cltbld', 04:44:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:26 INFO - '_': '/tools/buildbot/bin/python'} 04:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:26 INFO - Cleaning up... 04:44:26 INFO - Return code: 0 04:44:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:26 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 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:44:26 INFO - Using env: {'DISPLAY': ':0', 04:44:26 INFO - 'HOME': '/home/cltbld', 04:44:26 INFO - 'LANG': 'en_US.UTF-8', 04:44:26 INFO - 'LANGUAGE': 'en_US:en', 04:44:26 INFO - 'LOGNAME': 'cltbld', 04:44:26 INFO - 'MAIL': '/var/mail/cltbld', 04:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:26 INFO - 'MOZ_NO_REMOTE': '1', 04:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:26 INFO - 'NO_EM_RESTART': '1', 04:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:26 INFO - 'PWD': '/builds/slave/test', 04:44:26 INFO - 'SHELL': '/bin/bash', 04:44:26 INFO - 'SHLVL': '1', 04:44:26 INFO - 'TERM': 'linux', 04:44:26 INFO - 'TMOUT': '86400', 04:44:26 INFO - 'USER': 'cltbld', 04:44:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:26 INFO - '_': '/tools/buildbot/bin/python'} 04:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44: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 04:44:29 INFO - Downloading docopt-0.6.1.tar.gz 04:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:29 INFO - Running setup.py install for blobuploader 04:44:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:29 INFO - Running setup.py install for requests 04:44:29 INFO - Running setup.py install for docopt 04:44:29 INFO - Successfully installed blobuploader requests docopt 04:44:29 INFO - Cleaning up... 04:44:30 INFO - Return code: 0 04:44:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:30 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 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:30 INFO - Using env: {'DISPLAY': ':0', 04:44:30 INFO - 'HOME': '/home/cltbld', 04:44:30 INFO - 'LANG': 'en_US.UTF-8', 04:44:30 INFO - 'LANGUAGE': 'en_US:en', 04:44:30 INFO - 'LOGNAME': 'cltbld', 04:44:30 INFO - 'MAIL': '/var/mail/cltbld', 04:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:30 INFO - 'MOZ_NO_REMOTE': '1', 04:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:30 INFO - 'NO_EM_RESTART': '1', 04:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:30 INFO - 'PWD': '/builds/slave/test', 04:44:30 INFO - 'SHELL': '/bin/bash', 04:44:30 INFO - 'SHLVL': '1', 04:44:30 INFO - 'TERM': 'linux', 04:44:30 INFO - 'TMOUT': '86400', 04:44:30 INFO - 'USER': 'cltbld', 04:44:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:30 INFO - '_': '/tools/buildbot/bin/python'} 04:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:30 INFO - Running setup.py (path:/tmp/pip-7xp4eA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:30 INFO - Running setup.py (path:/tmp/pip-JlsyWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:30 INFO - Running setup.py (path:/tmp/pip-OiRJNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:30 INFO - Running setup.py (path:/tmp/pip-ShHQor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:30 INFO - Running setup.py (path:/tmp/pip-C_qiI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:30 INFO - Running setup.py (path:/tmp/pip-lUh8et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:30 INFO - Running setup.py (path:/tmp/pip-Nktjd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:30 INFO - Running setup.py (path:/tmp/pip-rty5g7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:30 INFO - Running setup.py (path:/tmp/pip-7KOOTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:30 INFO - Running setup.py (path:/tmp/pip-l6XUlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:31 INFO - Running setup.py (path:/tmp/pip-2Mv6Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:31 INFO - Running setup.py (path:/tmp/pip-YYS60b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:31 INFO - Running setup.py (path:/tmp/pip-Iby14l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:31 INFO - Running setup.py (path:/tmp/pip-NjeQGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:31 INFO - Running setup.py (path:/tmp/pip-vCrQxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:31 INFO - Running setup.py (path:/tmp/pip-1vuGYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:31 INFO - Running setup.py (path:/tmp/pip-b4pwVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:44:31 INFO - Running setup.py install for manifestparser 04:44:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Running setup.py install for mozcrash 04:44:31 INFO - Running setup.py install for mozdebug 04:44:31 INFO - Running setup.py install for mozdevice 04:44:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:44:31 INFO - Running setup.py install for mozfile 04:44:32 INFO - Running setup.py install for mozhttpd 04:44:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozinfo 04:44:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozInstall 04:44:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozleak 04:44:32 INFO - Running setup.py install for mozlog 04:44:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for moznetwork 04:44:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozprocess 04:44:32 INFO - Running setup.py install for mozprofile 04:44:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozrunner 04:44:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:44:32 INFO - Running setup.py install for mozscreenshot 04:44:33 INFO - Running setup.py install for moztest 04:44:33 INFO - Running setup.py install for mozversion 04:44:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:44:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:44:33 INFO - Cleaning up... 04:44:33 INFO - Return code: 0 04:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:33 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 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:33 INFO - Using env: {'DISPLAY': ':0', 04:44:33 INFO - 'HOME': '/home/cltbld', 04:44:33 INFO - 'LANG': 'en_US.UTF-8', 04:44:33 INFO - 'LANGUAGE': 'en_US:en', 04:44:33 INFO - 'LOGNAME': 'cltbld', 04:44:33 INFO - 'MAIL': '/var/mail/cltbld', 04:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:33 INFO - 'MOZ_NO_REMOTE': '1', 04:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:33 INFO - 'NO_EM_RESTART': '1', 04:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:33 INFO - 'PWD': '/builds/slave/test', 04:44:33 INFO - 'SHELL': '/bin/bash', 04:44:33 INFO - 'SHLVL': '1', 04:44:33 INFO - 'TERM': 'linux', 04:44:33 INFO - 'TMOUT': '86400', 04:44:33 INFO - 'USER': 'cltbld', 04:44:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:33 INFO - '_': '/tools/buildbot/bin/python'} 04:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:33 INFO - Running setup.py (path:/tmp/pip-lK_35Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:33 INFO - Running setup.py (path:/tmp/pip-oWZPgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:33 INFO - Running setup.py (path:/tmp/pip-2Expt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:33 INFO - Running setup.py (path:/tmp/pip-aGQAv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:33 INFO - Running setup.py (path:/tmp/pip-G5Vnxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:33 INFO - Running setup.py (path:/tmp/pip-II_DfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:33 INFO - Running setup.py (path:/tmp/pip-OvLhFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:34 INFO - Running setup.py (path:/tmp/pip-Oh8ih1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:34 INFO - Running setup.py (path:/tmp/pip-VnJAP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:34 INFO - Running setup.py (path:/tmp/pip-XE_sWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:34 INFO - Running setup.py (path:/tmp/pip-2YpvNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:44:34 INFO - Running setup.py (path:/tmp/pip-DtPpXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:44:34 INFO - Running setup.py (path:/tmp/pip-9cVuIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:44:34 INFO - Running setup.py (path:/tmp/pip-mdyeZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:34 INFO - Running setup.py (path:/tmp/pip-MXqVDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:44:34 INFO - Running setup.py (path:/tmp/pip-vspiVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:44:34 INFO - Running setup.py (path:/tmp/pip-v9GssE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:44:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:36 INFO - Downloading blessings-1.6.tar.gz 04:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:44:36 INFO - Installing collected packages: blessings 04:44:36 INFO - Running setup.py install for blessings 04:44:36 INFO - Successfully installed blessings 04:44:36 INFO - Cleaning up... 04:44:36 INFO - Return code: 0 04:44:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:37 INFO - Reading from file tmpfile_stdout 04:44:37 INFO - Current package versions: 04:44:37 INFO - argparse == 1.2.1 04:44:37 INFO - blessings == 1.6 04:44:37 INFO - blobuploader == 1.2.4 04:44:37 INFO - docopt == 0.6.1 04:44:37 INFO - functools32 == 3.2.3-2 04:44:37 INFO - jsonschema == 2.5.1 04:44:37 INFO - manifestparser == 1.1 04:44:37 INFO - mozInstall == 1.12 04:44:37 INFO - mozcrash == 0.17 04:44:37 INFO - mozdebug == 0.1 04:44:37 INFO - mozdevice == 0.48 04:44:37 INFO - mozfile == 1.2 04:44:37 INFO - mozhttpd == 0.7 04:44:37 INFO - mozinfo == 0.9 04:44:37 INFO - mozleak == 0.1 04:44:37 INFO - mozlog == 3.3 04:44:37 INFO - moznetwork == 0.27 04:44:37 INFO - mozprocess == 0.23 04:44:37 INFO - mozprofile == 0.28 04:44:37 INFO - mozrunner == 6.12 04:44:37 INFO - mozscreenshot == 0.1 04:44:37 INFO - mozsystemmonitor == 0.3 04:44:37 INFO - moztest == 0.7 04:44:37 INFO - mozversion == 1.4 04:44:37 INFO - psutil == 3.1.1 04:44:37 INFO - requests == 1.2.3 04:44:37 INFO - wsgiref == 0.1.2 04:44:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 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 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:37 INFO - Using env: {'DISPLAY': ':0', 04:44:37 INFO - 'HOME': '/home/cltbld', 04:44:37 INFO - 'LANG': 'en_US.UTF-8', 04:44:37 INFO - 'LANGUAGE': 'en_US:en', 04:44:37 INFO - 'LOGNAME': 'cltbld', 04:44:37 INFO - 'MAIL': '/var/mail/cltbld', 04:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:37 INFO - 'MOZ_NO_REMOTE': '1', 04:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:37 INFO - 'NO_EM_RESTART': '1', 04:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:37 INFO - 'PWD': '/builds/slave/test', 04:44:37 INFO - 'SHELL': '/bin/bash', 04:44:37 INFO - 'SHLVL': '1', 04:44:37 INFO - 'TERM': 'linux', 04:44:37 INFO - 'TMOUT': '86400', 04:44:37 INFO - 'USER': 'cltbld', 04:44:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:37 INFO - '_': '/tools/buildbot/bin/python'} 04:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:44:37 INFO - Cleaning up... 04:44:37 INFO - Return code: 0 04:44:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:37 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 0x271d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29de180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, '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': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:44:37 INFO - Using env: {'DISPLAY': ':0', 04:44:37 INFO - 'HOME': '/home/cltbld', 04:44:37 INFO - 'LANG': 'en_US.UTF-8', 04:44:37 INFO - 'LANGUAGE': 'en_US:en', 04:44:37 INFO - 'LOGNAME': 'cltbld', 04:44:37 INFO - 'MAIL': '/var/mail/cltbld', 04:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:37 INFO - 'MOZ_NO_REMOTE': '1', 04:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:37 INFO - 'NO_EM_RESTART': '1', 04:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:37 INFO - 'PWD': '/builds/slave/test', 04:44:37 INFO - 'SHELL': '/bin/bash', 04:44:37 INFO - 'SHLVL': '1', 04:44:37 INFO - 'TERM': 'linux', 04:44:37 INFO - 'TMOUT': '86400', 04:44:37 INFO - 'USER': 'cltbld', 04:44:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:37 INFO - '_': '/tools/buildbot/bin/python'} 04:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:44:37 INFO - Cleaning up... 04:44:37 INFO - Return code: 0 04:44:37 INFO - Running post-action listener: _resource_record_post_action 04:44:37 INFO - Running post-action listener: _start_resource_monitoring 04:44:37 INFO - Starting resource monitoring. 04:44:37 INFO - [mozharness: 2016-07-29 11:44:37.579195Z] Finished create-virtualenv step (success) 04:44:37 INFO - [mozharness: 2016-07-29 11:44:37.579687Z] Running install step. 04:44:37 INFO - Running pre-action listener: _resource_record_pre_action 04:44:37 INFO - Running main action method: install 04:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:44:37 INFO - Reading from file tmpfile_stdout 04:44:37 INFO - Detecting whether we're running mozinstall >=1.0... 04:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:44:37 INFO - Reading from file tmpfile_stdout 04:44:37 INFO - Output received: 04:44:37 INFO - Usage: mozinstall [options] installer 04:44:37 INFO - Options: 04:44:37 INFO - -h, --help show this help message and exit 04:44:37 INFO - -d DEST, --destination=DEST 04:44:37 INFO - Directory to install application into. [default: 04:44:37 INFO - "/builds/slave/test"] 04:44:37 INFO - --app=APP Application being installed. [default: firefox] 04:44:37 INFO - mkdir: /builds/slave/test/build/application 04:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:44:54 INFO - Reading from file tmpfile_stdout 04:44:54 INFO - Output received: 04:44:54 INFO - /builds/slave/test/build/application/firefox/firefox 04:44:54 INFO - Running post-action listener: _resource_record_post_action 04:44:54 INFO - [mozharness: 2016-07-29 11:44:54.290320Z] Finished install step (success) 04:44:54 INFO - [mozharness: 2016-07-29 11:44:54.290598Z] Running run-tests step. 04:44:54 INFO - Running pre-action listener: _resource_record_pre_action 04:44:54 INFO - Running main action method: run_tests 04:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:54 INFO - Python 2.7.3 04:44:54 INFO - Return code: 0 04:44:54 INFO - grabbing minidump binary from tooltool 04:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:54 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29dc3b0>, '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 0x29dd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29dd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:44:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:44:54 INFO - Calling ['/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'] with output_timeout 600 04:44:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:54 INFO - Return code: 0 04:44:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:44:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:44:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:54 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/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:44:54 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/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:44:54 INFO - Using env: {'DISPLAY': ':0', 04:44:54 INFO - 'HOME': '/home/cltbld', 04:44:54 INFO - 'LANG': 'en_US.UTF-8', 04:44:54 INFO - 'LANGUAGE': 'en_US:en', 04:44:54 INFO - 'LOGNAME': 'cltbld', 04:44:54 INFO - 'MAIL': '/var/mail/cltbld', 04:44:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:54 INFO - 'MOZ_NO_REMOTE': '1', 04:44:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:54 INFO - 'NO_EM_RESTART': '1', 04:44:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:54 INFO - 'PWD': '/builds/slave/test', 04:44:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:54 INFO - 'SHELL': '/bin/bash', 04:44:54 INFO - 'SHLVL': '1', 04:44:54 INFO - 'TERM': 'linux', 04:44:54 INFO - 'TMOUT': '86400', 04:44:54 INFO - 'USER': 'cltbld', 04:44:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199', 04:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:54 INFO - '_': '/tools/buildbot/bin/python'} 04:44:54 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/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:44:54 INFO - mozversion application_buildid: 20160729033626 04:44:54 INFO - mozversion application_changeset: 0d59012b60b0a9f305e0e506ae954dbc28b55ffa 04:44:54 INFO - mozversion application_display_name: Nightly 04:44:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:54 INFO - mozversion application_name: Firefox 04:44:54 INFO - mozversion application_remotingname: firefox 04:44:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:44:54 INFO - mozversion application_vendor: Mozilla 04:44:54 INFO - mozversion application_version: 50.0a1 04:44:54 INFO - mozversion platform_buildid: 20160729033626 04:44:54 INFO - mozversion platform_changeset: 0d59012b60b0a9f305e0e506ae954dbc28b55ffa 04:44:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:44:54 INFO - mozversion platform_version: 50.0a1 04:44:54 INFO - using testdate: 1469792694 04:44:54 INFO - actual date: 1469792694 04:44:54 INFO - starting webserver on 'localhost:46291' 04:44:54 INFO - SUITE-START | Running 2 tests 04:44:54 INFO - TEST-START | dromaeo_css 04:44:54 INFO - operating with platform_type : linux_ 04:44:54 INFO - Initialising browser for dromaeo_css test... 04:44:54 INFO - TEST-INFO | started process 4576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmh2zCr/profile http://localhost:46291/getInfo.html) 04:44:58 INFO - PROCESS | 4576 | JavaScript error: , line 0: uncaught exception: undefined 04:44:59 INFO - PROCESS | 4576 | __metrics Screen width/height:1600/1200 04:44:59 INFO - PROCESS | 4576 | colorDepth:24 04:44:59 INFO - PROCESS | 4576 | Browser inner width/height: 1024/697 04:44:59 INFO - PROCESS | 4576 | __metrics 04:44:59 INFO - PROCESS | 4576 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:44:59 INFO - PROCESS | 4576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:00 INFO - PROCESS | 4576 | console.error: PushService: 04:45:00 INFO - PROCESS | 4576 | stateChangeProcessEnqueue: Error transitioning state 04:45:00 INFO - PROCESS | 4576 | UnknownError 04:45:00 INFO - TEST-INFO | 4576: exit 0 04:45:00 INFO - Browser initialized. 04:45:00 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:00 INFO - TEST-INFO | started process 4655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmh2zCr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:12 INFO - PROCESS | 4655 | RSS: Main: 159277056 04:45:12 INFO - PROCESS | 4655 | 04:46:04 INFO - PROCESS | 4655 | 1469792764034 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:48:16 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:46291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46291/tests/dromaeo/cssquery-ext.html) 04:48:17 INFO - PROCESS | 4655 | RSS: Main: 241922048 04:48:17 INFO - PROCESS | 4655 | 04:51:20 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:46291/tests/dromaeo/cssquery-ext.html (next: http://localhost:46291/tests/dromaeo/cssquery-jquery.html) 04:51:21 INFO - PROCESS | 4655 | RSS: Main: 247054336 04:51:21 INFO - PROCESS | 4655 | 04:54:23 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:46291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46291/tests/dromaeo/cssquery-mootools.html) 04:54:23 INFO - PROCESS | 4655 | RSS: Main: 191012864 04:54:23 INFO - PROCESS | 4655 | 04:57:26 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:46291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46291/tests/dromaeo/cssquery-prototype.html) 04:57:26 INFO - PROCESS | 4655 | RSS: Main: 189788160 04:57:26 INFO - PROCESS | 4655 | 05:00:29 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:46291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46291/tests/dromaeo/cssquery-yui.html) 05:00:30 INFO - PROCESS | 4655 | RSS: Main: 190283776 05:00:30 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | Cycle 1(1): loaded http://localhost:46291/tests/dromaeo/cssquery-yui.html (next: http://localhost:46291/tests/dromaeo/cssquery-dojo.html) 05:03:33 INFO - PROCESS | 4655 | RSS: Main: 280862720 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | __start_tp_report 05:03:33 INFO - PROCESS | 4655 | _x_x_mozilla_page_load 05:03:33 INFO - PROCESS | 4655 | _x_x_mozilla_page_load_details 05:03:33 INFO - PROCESS | 4655 | |i|pagename|runs| 05:03:33 INFO - PROCESS | 4655 | |0;dojo.html;2645.391559941212;2645.5370310195717;2674.1175412114003;2686.1001564475887;2691.031228757647;4567.063751930855;4651.837185698493;4729.172394830904;4792.281157826328;4799.016201678652;4699.694519856215;4731.858044258669;4747.121782470245;4772.73749943753;4814.66297359185;4340.066885619591;4358.171947330013;4424.646028317727;4478.820847166109;4557.20248956433;4480.48474425442;4505.098980203972;4520.412346394981;4536.024754677744;4543.273076307792;4294.63495602871;4329.891752706176;4337.934930976006;4357.760323182224;4410.75740834254;4380.18966491197;4388.89027774305;4414.602685758297;4415.977920110379;4478.798454069574;4449.844255451044;4450.643948484146;4456.465224173087;4490.977545112253;4504.256797628387;4622.19111655459;4696.178168820443;4819.421669399694;4833.975830120827;4885.828995985159;4993.850184494471;5125.974370128163;5127.66670166438;5172.61205409592;5179.715115668637;5151.407588127376;5158.9484105158845;5199.350081239845;5204.739763011872;5219.608529360313;4648.558386953234;4694;4729.314249433813;4866.805327786884;4869.172240719086;5133.512316329943;5178.97410512945;5199.194124910645;5207.1668533034535;5212.478752124757;4980.626453015966;4981.90036199274;5001.349824522861;5012.749362531858;5014.0974624567925;4929.876753081202;5028.044671512401;5110.71891045996;5122.231665250168;5123.3339665843205;5106.693598384109;5115.232715092691;5120.871978200575;5137.5376216139975;5149.871253218699;5077.365329333833;5080.872978175501;5081.3140226069745;5090.0583392072585;5142.254373115878;4182.811773470201;4336.718113322624;4340.978295108504;4343.261645520206;4386.188555117314;3709.6104908984166;3755.7183211259266;3786.6213378662464;3824.4072168813877;3878.4764056852528;4404.537523560044;4413.426254586883;4415.62467190286;4419.160359531678;4471.731696098244;5116.606503602259;5134.460881607378;5143.254228136974;5145.331106956071;5180.326557547494;4253.468316460442;4341.305391137403;4354.869353919387;4386.583274588909;4405.867823965286;4585.679002469795;4590.655700822452;4607.642867819229;4636.235021221461;4637.443506779208;4772.451168115642;4777.689450185727;4778.163821331323;4791.401074865642;4823.3729615149805;4932.827351042696;4979.526944940225;5052.418971818288;5104.770285337243;5117.8464646060675;4769.3084502746215;4782.832600858953;4794.2808578713475;4798.880027999328;4833.081714474239;5022.673526220784;5023.146065169003;5023.497650234947;5025.271335656383;5079.3650793650795;4952.826651067196;5061.367329083864;5071.340725705634;5081.3902331718955;5136.1268584340005;4983.352164218629;4983.700977941335;4984.551390374883;5024.0956627807345;5037.823676171463;4986.675866068694;4993.875153121201;4995.225740010304;4998.100341938486;5043.798248070183;4714.764261786965;4851.51484851512;4867.464578896248;4886.682365646222;4943.332650092191;5070.898582028265;5072.289879416959;5076.517730815566;5089.821856235014;5098.2862399263395;4941.135301322326;4947.876303092451;4957.206846904478;4961.231009193581;5005.474425185449 05:03:33 INFO - PROCESS | 4655 | |1;ext.html;569.0070826407922;571.9599628026037;574.5862978655368;581.5434883616362;596.4900010491031;29602.555961660564;39604.40593391102;40917.3862392064;40953.59046409535;45038.32442513357;41312.38031429531;41720.79139604298;41758;41817.37273940886;41850;7669.309762121422;7845.64694588742;7847.96076019622;7849.8037549061155;7852.136265010873;7515.511491753018;9764.853527197098;9945.40327580344;10022.496625506159;10379.065884070433;10091.444970526618;10176.847347289797;10183.236257280734;10199.949000254988;10204.642837500689;10023.548940297667;10046.346987445793;10049.995000499928;10077.546510406975;10086.798264034678;9889.90110098897;9953.850692239623;9960.850587241197;9973.75065623358;9976.201903847676;39041;39251.8037409814;39364.40953385702;39428.80285598582;39450.80274598609;2993.8652760625823;3179.5071763876635;3629.4192929131477;3638.981805090984;3711.3690672585726;27551.586726199122;29487.55768663472;29562.70437295621;29718.405631887243;31140;2766.7233276672373;2821.1677555121287;2821.252368122429;2829.9292517687018;2831.7593004594632;257119;258433;260135;260252;260492;55062.17406738902;55335.44664553383;55412.44587554153;55471.44528554663;55517.72241138769;32981;34057.48913766295;34099.829500852335;35812.283754324766;35833.64166358355;15149.469768558047;15256.618584535254;15299.46451874179;15333.080015199124;15336.003159794578;10356.223283253787;11358.545658173745;11370.488328025258;11448.885511144948;11448.942755286336;17622.91188544049;18209.7268540972;18222.36221732233;18324;18508.074596270402;6708.865822683519;6841.657917104125;6853.17761868579;7045.225025247219;7073.681684324218;794.8251384695358;872.1801506583791;929.6049179098856;948.8292107420731;961.4615815143542;27966.72033279682;28281.15156545307;28437.72462510844;28657.283567910552;28899.277518061797;951.2342564235719;965.9034096590285;967.5307475874196;995.6117114325419;1023.498485741996;14877;15022.173780441963;15092.698146037017;15301.846981530265;15316.081035137928;400904;402238;404625;404683;404989;50228.49771502238;50825.74587127041;50895.491045089075;51026.489735102914;51046.48953510492;1075.860138182047;1124.7975364434317;1130.2879186112696;1178.1517307538559;1210.8002179640437;25863.741362586134;29645.110646680634;29686.367249801468;30073.69926300709;30115.698843012167;44083.55916440795;44680.32979505375;44690;44903.550964491245;44940;346614;348484;350389;350822;350905;33905.66094339025;34958.12604684903;38789.806050969564;43165.76256780817;43590.78204609083;43275.56724432841;43606.34590481082;43723.34414983841;43782;43796.12407751891;36449.817750911076;36516.45225321569;36931.446028310136;37334.066648332926;38126.046848829;36137.45793813042;36924.815375922946;37067.443988339655;37307.81346093252;37348.81325593355;36395.818020909726;36429.5360660944;37027.444588330654;37431.62568374391;37772.24455510819;31249;33217.335653287286;33570.328593427505;33587;34128.14679633029;25005;25732.742672573782;27334;27781.602761914335;27944.02195923214 05:03:33 INFO - PROCESS | 4655 | |2;jquery.html;353.91329124364535;364.9963500364996;368.4344531144692;369.99260014799705;374.32994939059085;12697.809532857003;13472.797908031387;14476.5657030289;17187.82812171878;17218.483445496655;16577.17114144291;16730.498085057436;16741.748873766905;16799.328026878942;16806.915965420158;3947.684185265172;5010.549050585447;6206.534509911752;6211.720472578722;6325.493960483151;6182.350853160421;6184.8453788655415;6197.194364732579;6251.749930002818;6265.937340626604;6190.721417536199;6190.78332258371;6206.596571222879;6211.596246243979;6217.502599792028;5945.16767652529;5987.850303742442;6130.2030736004035;6167.938320616804;6171.783987560436;5332.706701131437;5335.599830012726;5336.51971322579;5338.119210330291;5341.4658534146665;20045.298414555422;20134.69797953032;20318.187272509083;20325.593488130155;20477.283295084602;1892.6025534637743;1909.789923108457;1925.7977912319145;1967.1344608372412;2389.295157928398;12495.562655307021;13281.667958301023;13323.54322134651;13509.527166549124;13940.58178254654;1447.833499147601;1540.099042060396;1549.4422008077083;1561.36764610333;1608.8230294667578;43050;54467;68600.6569967152;69551;70430.64784676096;9755.512224388753;9806.411615303105;9866.210703143732;9908.900910990798;10138.695839124837;13728.313584320744;13752.587422377344;13754.65613359674;13775.311234438239;13802.447902083804;7349.375303099297;7511.737089201961;7565.848683026308;7665.386769058462;7706.961465192639;7081.752138675121;7153.642317884085;7198.532095413886;7351.301626345488;7362.631868406558;6212.565120441616;6264.9373506265265;6300.117983482316;6300.653464059521;6315.747370105144;1780.305680784495;1807.2228941554995;1813.519417354402;1822.2437688359448;1843.9446816595523;796.307212724933;809.906860711014;835.5863847395578;843.7974886027432;872.3631748823394;16865.241064152142;17034.82965170357;17343;17822.55443613894;17873;843.7848348671049;848.6435697007272;870.4037734151999;891.9241864441466;942.2085448223526;9451.054894510495;9548.522573871278;9625.278104142217;9876;10304.742381440374;405682;410026;410622;422642;427245;84582.5770871154;86118;86524.5673771627;88021.5598922014;88419.55790221137;888.6356593796512;896.5114012863005;947.1191791633709;950.4202436513721;950.7623094226443;15375.077495350315;15767.68464630724;16191.190440477694;16278.43025494102;16580.0880951544;38299.70201787902;38714.6128538711;39298.80350598229;39373.80313098416;39684;47762.522374777196;51833.7408312956;52264.47735522596;52885.7355713219;54662.45337546574;7483.588402637907;7579.658915348712;7710.036245469317;7749.41879359039;7941.920580794349;10364.326318789255;10985.890141098806;11088.279261847954;11972.880271197177;12204.938975305067;9930.851037234592;10025.348352357074;10042.69871903844;10152.441615710912;10499.107575856138;9841.557129929028;9928.503574821374;9977.650782222878;10121.746956326151;10759.085477734166;10056.748581285234;10157.644482443078;10283.94858025705;10546.947265263625;10720.303180293256;7321.341079302888;7336.156342020522;7368.4842061055215;7461.291177338144;7990.760277191694;8183.631736571988;9767.169790567597;9926.652567160114;10142.54358553852;10549.156067514426 05:03:33 INFO - PROCESS | 4655 | |3;mootools.html;1178.858536975563;1313.7109835836113;1363.2365875109936;1405.7399381114487;1715.4939292908591;6747.56140850845;7376;7623.771286861389;7629.504082234658;7810.8047298817555;7672.271134242252;7724.845503089935;7734.922650773505;7741.9225807741905;7743;2167.945801354967;2204.47092697753;2205.2391924785925;2207.0289072807914;2208.712867327245;2138.2302371146375;2198.527316626925;2199.263246812312;2200.3618950504333;2211.9778802212013;2163.134746101564;2185.825133989277;2188.1794327127327;2190.1348967157965;2198.109765544949;2108.2621082621113;2108.546662467569;2108.8523803333774;2111.767705552388;2112.0812446585633;2065.297798748418;2083.5207902182433;2111.9788802111934;2117.587070521249;2124.2989813361555;7627.199144089846;7727.845443091107;7746.225377462265;7793.688252469894;7798.064232292161;4594.908101837945;4754.168020596382;4758.2386818108935;4759.666823322369;4764.0948219838465;2771.362586605092;2888.7400133988044;2933.911982640524;2937.735603795669;2939.6031535742827;893.263057977165;899.6131663384742;901.1349104859343;902.5351943748974;914.9313801464916;10406.271560990734;10528.842067368996;10531.210159238088;10548.20888433363;10553.894461055368;3845.4616353710503;4011.7392369495888;4145.0880806222585;4149.854755083557;4193.391958166048;8308.626111824982;8315.501069935823;8321.41750077501;8325;8336.916630833735;4568.497465278817;4570.063137056895;4573.222552166139;4583.129205450954;4584.3352713856975;3626.5829429615405;4102.405151253051;4240.300350442204;4271.209826182167;4271.231178387858;3383.120388698907;3383.3064221834466;3506.6142724300307;3512.7892326459983;3513.4554144107706;1005.4520286443759;1031.896810318962;1037.4086770540719;1039.0804138337626;1040.7710303733168;653.3433898931544;823.8064054947083;849.1890244816186;849.8512760266929;864.9091845356147;5026.773795179226;5113.769880355393;5130.871208334161;5266.1574148136115;5312.2297266896085;416.3151615592334;423.33536347934063;423.37129362896076;423.5785393533454;428.9383775156525;3555.235624340779;3561.394562924309;3689.428138638462;3754.8685795997008;3778.2065766188857;9397.718068457958;9858.901410985942;9870.753231169278;9874.703758887244;9880.209583233323;9832.410055396698;9842.852357214648;9844;9857.162141218078;9865.161461275871;7352.926470735224;7424.888626670604;7444.218357072429;7455.85088298231;7462.365698915653;4980.626453016111;5183.377994640668;5224.1641337387355;5229.294045303987;5355.866103347447;8812.823743525221;8847.292216622784;8949.105089490999;8974.86537701922;9050.909490905007;9021.458712477272;9123.361364704408;9188.954055229948;9199.770005749642;9219.677311294072;5824.592278540462;6226.564140510302;6444.613323200623;6529.183852018497;6534.346565343618;7278.563286202845;7533.773986780406;7537.886931696139;7570.9242907572425;7580.279873412238;6563.113979612691;6583.63789991555;6617.702203400762;6723.831904202434;6788.287229840796;6527.738890444519;6572.737090516326;6595.208574971034;6698.196216454056;6700.6984685688285;5955.821325360246;6066.362082237682;6067.848303792441;6069.817905462666;6076.210092687922;4280.122574872206;4403.273459879084;4424.823007079681;4432.29083346663;4495.662825288051;4320.265554855745;4371.715838470489;4376.671749618855;4532.161550113239;4602.056578401487 05:03:33 INFO - PROCESS | 4655 | |4;prototype.html;290.6120329360304;293.40585314737655;302.2639871911894;306.1779123054597;308.4217092950716;4783.569478746912;4792.880177995552;4831.830885918994;4832.130216561022;4851.927221091686;4778.856634300968;4792.712437253767;4793.257045158006;4798.304245884345;4889.633277504193;3617.294627547623;3711.1278849470355;3723.385641369171;3724.3854763963914;3734.5705243897028;3652.506911566931;3695.353313170198;3776.150366167618;3779.2441511697634;3795.3737633290475;3744.6817020553285;3756.774593524384;3759.3308750786973;3760.8683696070643;3762.811859407019;3531.823408829548;3722.3671975764187;3755.680767134797;3776.1692427666007;3813.103920578648;3235.7573182011442;3272.689094536015;3282.097423208613;3288.96711032889;3293.386240742043;4627.629789616823;4649.442066951988;4675.135100006476;4729.290606409032;4744.335792988984;4094.344904815245;4233.30150525166;4254.7021708480415;4263.7828329268605;4273.97863010683;4988.87527811804;4990.3762029746285;4991.450940396553;4996.4503904570465;4998.475464983178;3594.478800573902;3598.5681718193723;3598.8047291152375;3605.5132557104716;3641.908952276214;5064.392272927235;5200.29795977542;5220.477952204749;5256.369235691704;5257.8159764408065;3638.7816730996224;3652.6712595866497;3653.4702468141973;3666.578343490533;3679.988003299114;3685.875807878569;3694.242680250542;3705.2404257127764;3710.276496083292;3738.12154143776;4200.6056547767475;4229.6404805591255;4231.703780735319;4238.194742998882;4239.703220774516;4835.7427068961615;4996.950030499721;5011.448740638527;5039.647224694236;5039.866030143188;1264.1151194164122;1279.1238001968682;1279.731256436159;1281.4745954158936;1281.8911641430282;774.531408497862;823.012385137837;823.4030328012263;829.2702421868717;829.7261903571807;4268.335349213809;4375.978120109379;4421.734695918255;4483.005062747046;4486.913585182906;5162.432132465426;5177.896442071137;5186.792528298901;5190.2214667800135;5191;4466.531014243523;4471.530489298641;4479.686421950432;4484.686071974996;4493.236149854532;2628.4874449482168;2718.3747738020365;2734.5214587447117;2734.740199681027;2736.53478908586;4863.781129849165;4866.270059491105;4869.639948435639;4871.95128048715;4881.633877459205;5049.343585333957;5195.922061169085;5285.418603953639;5286.092649043011;5295.205719142083;4847.175980083394;4855.757212139379;4865.878353041202;4877.244027175793;4877.463479017234;5170.121079416433;5170.948290517047;5179.48205179479;5183.315422487632;5188.299579556711;4932.4081110267;5050.570701490415;5092.301080427379;5104.846854594368;5121.359830021247;4771.355866958055;4804.423469183581;4805.783739731791;4826.8069277228515;4834.105690447279;3640.344737947195;3653.70770338367;3654.1230104775195;3655.488231647518;3659.6889264411757;4977.203647416541;5127.92308115386;5137.229415587692;5158.97420512895;5162.9483705162465;4909.435414927186;4973.776180071978;4994.875128121826;4996.400431948189;5008.824691135793;4992.550670439678;4994.850154495371;4999.850004499871;5000.874978125576;5007.123753343078;4681.765911704333;4908.092002979461;4915.623625384898;4918.5573298403315;4920.269250565971;4768.594669453136;4902.730349830794;4985.326980857682;5001.624878134227;5052.621053420935;4861.951380486292;4891.315215869852;4891.413030436371;4891.877703057452;4902.803887844446 05:03:33 INFO - PROCESS | 4655 | |5;yui.html;574.597781552913;583.9503642190414;602.7980626490125;625.127946514612;649.5777744466094;11207.719807004829;11862.051035917139;11862.703432414182;12232.143749937508;12232.877671223285;11750.647480575575;11784.351860647683;11867.643970680894;11874.643760687171;11877;614.158602714281;736.484460877388;767.3170877918657;775.4843029385452;776.1423626892288;765.1086484245847;767.4090949968521;767.57399643198;767.8733009053527;767.996160019202;815.5310696349593;815.5310696349593;816.9387295952797;817.1787353709543;817.8159914019358;806.8749343851713;807.7657479330987;807.9474834135792;808.6159074439623;809.2191035650567;593.4984937727613;594.6640148316187;595.2618752746563;595.3272801734056;595.3421469276431;10863.456827158689;10906.454677266105;10984.176186786022;10985.890141098567;10989.230753847234;11645.6506304811;11736.765264694659;11824.290542567387;12086.530498208895;12198.268103913793;9292.349535532516;9494.382865113814;9551.188149007343;9580.90419095807;9746.074122958307;3090.5364195370876;3098.5971823663003;3111.984440077808;3114.361555881039;3121.9687803122133;43153;44420.77789611031;51987.22019169753;58450.41549584492;59087.40912590905;8732;9204.079592040742;9214.90785092154;9397.436153830791;9801.264905132144;17187.31250749981;17210.827891721172;17210.91394543019;17287.74068388975;17301.653966920592;6429.196350456193;6455.580387274812;6572.835679107965;6684.598924064571;6811.93188068113;3366.040678406642;3407.5059116428474;3581.4448760442174;3646.070252085701;3649.361361761681;2628.829126106797;2721.972780272172;2724.250831021485;2730.2218867622632;2735.261479400551;487.97316147612224;495.8462876508294;499.9500049995044;500.6670564074922;508.84480233529126;541.8482824809059;585.2274997003999;585.4730742331935;598.1745191635515;599.9130126131687;7104.502684812013;7115.1106111736035;7470.215627359158;7523.285287897641;7631;491.2739446524458;519.857039314184;540.3974568356255;582.6766144789598;590.271015296109;3504.9123771905397;3724.1806802503406;3811.4663947047434;3859.26673931952;3863.497745293094;93823.0617693828;95279;96792.35284118741;97159;99135;61570.38429615736;69880;79113;79461.60269198733;79509;70693;72049.27950720531;75407.86888196682;76031.61984190154;77221.61389193131;7934.722284720007;8120.350371970347;8235.588220589067;8304.543250121302;8399.202075802788;43569.78215109031;43958;45149;45866.541334587564;45999;59526.70236648789;59571.70214148902;65139.348606513326;67264;67960;10786.784264314827;10809.67570972872;10843.945780271048;10942.617008404668;11248.325100493996;11680.240784348991;11879.406029698308;11898.643040708792;11935.880641193477;11968.940155299168;10871.891281087088;11176.776464470828;11265.549378025114;11526.366049867001;11601.477933492844;10692.411917344622;10697.411642359433;11143.888561114285;11154.274972126786;11436.256643318158;10866.891331086588;10900.618478353219;11403.543858245908;11611.767764644828;11628.418579070843;9234.215091717278;9267.44395336282;9410.200132988499;9549.283803714889;9553.713388598353;8643.654253830027;8867.778305542413;9127.589258483516;9159.77100572491;9712.368696034735 05:03:33 INFO - PROCESS | 4655 | __end_tp_report 05:03:33 INFO - PROCESS | 4655 | __start_cc_report 05:03:33 INFO - PROCESS | 4655 | _x_x_mozilla_cycle_collect,952 05:03:33 INFO - PROCESS | 4655 | __end_cc_report 05:03:33 INFO - PROCESS | 4655 | __startTimestamp1469793813608__endTimestamp 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | ------- Summary: start ------- 05:03:33 INFO - PROCESS | 4655 | Number of tests: 6 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | [#0] dojo.html Cycles:165 Average:4723.53 Median:4833.98 stddev:492.11 (10.2%) stddev-sans-first:465.84 05:03:33 INFO - PROCESS | 4655 | Values: 2645.4 2645.5 2674.1 2686.1 2691.0 4567.1 4651.8 4729.2 4792.3 4799.0 4699.7 4731.9 4747.1 4772.7 4814.7 4340.1 4358.2 4424.6 4478.8 4557.2 4480.5 4505.1 4520.4 4536.0 4543.3 4294.6 4329.9 4337.9 4357.8 4410.8 4380.2 4388.9 4414.6 4416.0 4478.8 4449.8 4450.6 4456.5 4491.0 4504.3 4622.2 4696.2 4819.4 4834.0 4885.8 4993.9 5126.0 5127.7 5172.6 5179.7 5151.4 5158.9 5199.4 5204.7 5219.6 4648.6 4694.0 4729.3 4866.8 4869.2 5133.5 5179.0 5199.2 5207.2 5212.5 4980.6 4981.9 5001.3 5012.7 5014.1 4929.9 5028.0 5110.7 5122.2 5123.3 5106.7 5115.2 5120.9 5137.5 5149.9 5077.4 5080.9 5081.3 5090.1 5142.3 4182.8 4336.7 4341.0 4343.3 4386.2 3709.6 3755.7 3786.6 3824.4 3878.5 4404.5 4413.4 4415.6 4419.2 4471.7 5116.6 5134.5 5143.3 5145.3 5180.3 4253.5 4341.3 4354.9 4386.6 4405.9 4585.7 4590.7 4607.6 4636.2 4637.4 4772.5 4777.7 4778.2 4791.4 4823.4 4932.8 4979.5 5052.4 5104.8 5117.8 4769.3 4782.8 4794.3 4798.9 4833.1 5022.7 5023.1 5023.5 5025.3 5079.4 4952.8 5061.4 5071.3 5081.4 5136.1 4983.4 4983.7 4984.6 5024.1 5037.8 4986.7 4993.9 4995.2 4998.1 5043.8 4714.8 4851.5 4867.5 4886.7 4943.3 5070.9 5072.3 5076.5 5089.8 5098.3 4941.1 4947.9 4957.2 4961.2 5005.5 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | [#1] ext.html Cycles:180 Average:49509.68 Median:20017.40 stddev:90146.40 (450.3%) stddev-sans-first:90324.39 05:03:33 INFO - PROCESS | 4655 | Values: 569.0 572.0 574.6 581.5 596.5 29602.6 39604.4 40917.4 40953.6 45038.3 41312.4 41720.8 41758.0 41817.4 41850.0 7669.3 7845.6 7848.0 7849.8 7852.1 7515.5 9764.9 9945.4 10022.5 10379.1 10091.4 10176.8 10183.2 10199.9 10204.6 10023.5 10046.3 10050.0 10077.5 10086.8 9889.9 9953.9 9960.9 9973.8 9976.2 39041.0 39251.8 39364.4 39428.8 39450.8 2993.9 3179.5 3629.4 3639.0 3711.4 27551.6 29487.6 29562.7 29718.4 31140.0 2766.7 2821.2 2821.3 2829.9 2831.8 257119.0 258433.0 260135.0 260252.0 260492.0 55062.2 55335.4 55412.4 55471.4 55517.7 32981.0 34057.5 34099.8 35812.3 35833.6 15149.5 15256.6 15299.5 15333.1 15336.0 10356.2 11358.5 11370.5 11448.9 11448.9 17622.9 18209.7 18222.4 18324.0 18508.1 6708.9 6841.7 6853.2 7045.2 7073.7 794.8 872.2 929.6 948.8 961.5 27966.7 28281.2 28437.7 28657.3 28899.3 951.2 965.9 967.5 995.6 1023.5 14877.0 15022.2 15092.7 15301.8 15316.1 400904.0 402238.0 404625.0 404683.0 404989.0 50228.5 50825.7 50895.5 51026.5 51046.5 1075.9 1124.8 1130.3 1178.2 1210.8 25863.7 29645.1 29686.4 30073.7 30115.7 44083.6 44680.3 44690.0 44903.6 44940.0 346614.0 348484.0 350389.0 350822.0 350905.0 33905.7 34958.1 38789.8 43165.8 43590.8 43275.6 43606.3 43723.3 43782.0 43796.1 36449.8 36516.5 36931.4 37334.1 38126.0 36137.5 36924.8 37067.4 37307.8 37348.8 36395.8 36429.5 37027.4 37431.6 37772.2 31249.0 33217.3 33570.3 33587.0 34128.1 25005.0 25732.7 27334.0 27781.6 27944.0 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | [#2] jquery.html Cycles:180 Average:25332.40 Median:52575.11 stddev:68510.09 (130.3%) stddev-sans-first:68676.61 05:03:33 INFO - PROCESS | 4655 | Values: 353.9 365.0 368.4 370.0 374.3 12697.8 13472.8 14476.6 17187.8 17218.5 16577.2 16730.5 16741.7 16799.3 16806.9 3947.7 5010.5 6206.5 6211.7 6325.5 6182.4 6184.8 6197.2 6251.7 6265.9 6190.7 6190.8 6206.6 6211.6 6217.5 5945.2 5987.9 6130.2 6167.9 6171.8 5332.7 5335.6 5336.5 5338.1 5341.5 20045.3 20134.7 20318.2 20325.6 20477.3 1892.6 1909.8 1925.8 1967.1 2389.3 12495.6 13281.7 13323.5 13509.5 13940.6 1447.8 1540.1 1549.4 1561.4 1608.8 43050.0 54467.0 68600.7 69551.0 70430.6 9755.5 9806.4 9866.2 9908.9 10138.7 13728.3 13752.6 13754.7 13775.3 13802.4 7349.4 7511.7 7565.8 7665.4 7707.0 7081.8 7153.6 7198.5 7351.3 7362.6 6212.6 6264.9 6300.1 6300.7 6315.7 1780.3 1807.2 1813.5 1822.2 1843.9 796.3 809.9 835.6 843.8 872.4 16865.2 17034.8 17343.0 17822.6 17873.0 843.8 848.6 870.4 891.9 942.2 9451.1 9548.5 9625.3 9876.0 10304.7 405682.0 410026.0 410622.0 422642.0 427245.0 84582.6 86118.0 86524.6 88021.6 88419.6 888.6 896.5 947.1 950.4 950.8 15375.1 15767.7 16191.2 16278.4 16580.1 38299.7 38714.6 39298.8 39373.8 39684.0 47762.5 51833.7 52264.5 52885.7 54662.5 7483.6 7579.7 7710.0 7749.4 7941.9 10364.3 10985.9 11088.3 11972.9 12204.9 9930.9 10025.3 10042.7 10152.4 10499.1 9841.6 9928.5 9977.7 10121.7 10759.1 10056.7 10157.6 10283.9 10546.9 10720.3 7321.3 7336.2 7368.5 7461.3 7990.8 8183.6 9767.2 9926.7 10142.5 10549.2 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | [#3] mootools.html Cycles:180 Average:5056.96 Median:5003.70 stddev:2883.54 (57.6%) stddev-sans-first:2876.90 05:03:33 INFO - PROCESS | 4655 | Values: 1178.9 1313.7 1363.2 1405.7 1715.5 6747.6 7376.0 7623.8 7629.5 7810.8 7672.3 7724.8 7734.9 7741.9 7743.0 2167.9 2204.5 2205.2 2207.0 2208.7 2138.2 2198.5 2199.3 2200.4 2212.0 2163.1 2185.8 2188.2 2190.1 2198.1 2108.3 2108.5 2108.9 2111.8 2112.1 2065.3 2083.5 2112.0 2117.6 2124.3 7627.2 7727.8 7746.2 7793.7 7798.1 4594.9 4754.2 4758.2 4759.7 4764.1 2771.4 2888.7 2933.9 2937.7 2939.6 893.3 899.6 901.1 902.5 914.9 10406.3 10528.8 10531.2 10548.2 10553.9 3845.5 4011.7 4145.1 4149.9 4193.4 8308.6 8315.5 8321.4 8325.0 8336.9 4568.5 4570.1 4573.2 4583.1 4584.3 3626.6 4102.4 4240.3 4271.2 4271.2 3383.1 3383.3 3506.6 3512.8 3513.5 1005.5 1031.9 1037.4 1039.1 1040.8 653.3 823.8 849.2 849.9 864.9 5026.8 5113.8 5130.9 5266.2 5312.2 416.3 423.3 423.4 423.6 428.9 3555.2 3561.4 3689.4 3754.9 3778.2 9397.7 9858.9 9870.8 9874.7 9880.2 9832.4 9842.9 9844.0 9857.2 9865.2 7352.9 7424.9 7444.2 7455.9 7462.4 4980.6 5183.4 5224.2 5229.3 5355.9 8812.8 8847.3 8949.1 8974.9 9050.9 9021.5 9123.4 9189.0 9199.8 9219.7 5824.6 6226.6 6444.6 6529.2 6534.3 7278.6 7533.8 7537.9 7570.9 7580.3 6563.1 6583.6 6617.7 6723.8 6788.3 6527.7 6572.7 6595.2 6698.2 6700.7 5955.8 6066.4 6067.8 6069.8 6076.2 4280.1 4403.3 4424.8 4432.3 4495.7 4320.3 4371.7 4376.7 4532.2 4602.1 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | [#4] prototype.html Cycles:180 Average:4159.09 Median:4792.80 stddev:1208.06 (25.2%) stddev-sans-first:1176.03 05:03:33 INFO - PROCESS | 4655 | Values: 290.6 293.4 302.3 306.2 308.4 4783.6 4792.9 4831.8 4832.1 4851.9 4778.9 4792.7 4793.3 4798.3 4889.6 3617.3 3711.1 3723.4 3724.4 3734.6 3652.5 3695.4 3776.2 3779.2 3795.4 3744.7 3756.8 3759.3 3760.9 3762.8 3531.8 3722.4 3755.7 3776.2 3813.1 3235.8 3272.7 3282.1 3289.0 3293.4 4627.6 4649.4 4675.1 4729.3 4744.3 4094.3 4233.3 4254.7 4263.8 4274.0 4988.9 4990.4 4991.5 4996.5 4998.5 3594.5 3598.6 3598.8 3605.5 3641.9 5064.4 5200.3 5220.5 5256.4 5257.8 3638.8 3652.7 3653.5 3666.6 3680.0 3685.9 3694.2 3705.2 3710.3 3738.1 4200.6 4229.6 4231.7 4238.2 4239.7 4835.7 4997.0 5011.4 5039.6 5039.9 1264.1 1279.1 1279.7 1281.5 1281.9 774.5 823.0 823.4 829.3 829.7 4268.3 4376.0 4421.7 4483.0 4486.9 5162.4 5177.9 5186.8 5190.2 5191.0 4466.5 4471.5 4479.7 4484.7 4493.2 2628.5 2718.4 2734.5 2734.7 2736.5 4863.8 4866.3 4869.6 4872.0 4881.6 5049.3 5195.9 5285.4 5286.1 5295.2 4847.2 4855.8 4865.9 4877.2 4877.5 5170.1 5170.9 5179.5 5183.3 5188.3 4932.4 5050.6 5092.3 5104.8 5121.4 4771.4 4804.4 4805.8 4826.8 4834.1 3640.3 3653.7 3654.1 3655.5 3659.7 4977.2 5127.9 5137.2 5159.0 5162.9 4909.4 4973.8 4994.9 4996.4 5008.8 4992.6 4994.9 4999.9 5000.9 5007.1 4681.8 4908.1 4915.6 4918.6 4920.3 4768.6 4902.7 4985.3 5001.6 5052.6 4862.0 4891.3 4891.4 4891.9 4902.8 05:03:33 INFO - PROCESS | 4655 | 05:03:33 INFO - PROCESS | 4655 | [#5] yui.html Cycles:180 Average:16765.36 Median:29517.82 stddev:24255.75 (82.2%) stddev-sans-first:24293.33 05:03:33 INFO - PROCESS | 4655 | Values: 574.6 584.0 602.8 625.1 649.6 11207.7 11862.1 11862.7 12232.1 12232.9 11750.6 11784.4 11867.6 11874.6 11877.0 614.2 736.5 767.3 775.5 776.1 765.1 767.4 767.6 767.9 768.0 815.5 815.5 816.9 817.2 817.8 806.9 807.8 807.9 808.6 809.2 593.5 594.7 595.3 595.3 595.3 10863.5 10906.5 10984.2 10985.9 10989.2 11645.7 11736.8 11824.3 12086.5 12198.3 9292.3 9494.4 9551.2 9580.9 9746.1 3090.5 3098.6 3112.0 3114.4 3122.0 43153.0 44420.8 51987.2 58450.4 59087.4 8732.0 9204.1 9214.9 9397.4 9801.3 17187.3 17210.8 17210.9 17287.7 17301.7 6429.2 6455.6 6572.8 6684.6 6811.9 3366.0 3407.5 3581.4 3646.1 3649.4 2628.8 2722.0 2724.3 2730.2 2735.3 488.0 495.8 500.0 500.7 508.8 541.8 585.2 585.5 598.2 599.9 7104.5 7115.1 7470.2 7523.3 7631.0 491.3 519.9 540.4 582.7 590.3 3504.9 3724.2 3811.5 3859.3 3863.5 93823.1 95279.0 96792.4 97159.0 99135.0 61570.4 69880.0 79113.0 79461.6 79509.0 70693.0 72049.3 75407.9 76031.6 77221.6 7934.7 8120.4 8235.6 8304.5 8399.2 43569.8 43958.0 45149.0 45866.5 45999.0 59526.7 59571.7 65139.3 67264.0 67960.0 10786.8 10809.7 10843.9 10942.6 11248.3 11680.2 11879.4 11898.6 11935.9 11968.9 10871.9 11176.8 11265.5 11526.4 11601.5 10692.4 10697.4 11143.9 11154.3 11436.3 10866.9 10900.6 11403.5 11611.8 11628.4 9234.2 9267.4 9410.2 9549.3 9553.7 8643.7 8867.8 9127.6 9159.8 9712.4 05:03:33 INFO - PROCESS | 4655 | -------- Summary: end -------- 05:03:33 INFO - PROCESS | 4655 | 05:03:34 INFO - TEST-INFO | 4655: exit 0 05:03:34 INFO - TEST-OK | dromaeo_css | took 1119938ms 05:03:34 INFO - TEST-START | kraken 05:03:34 INFO - operating with platform_type : linux_ 05:03:34 INFO - Initialising browser for kraken test... 05:03:34 INFO - TEST-INFO | started process 4849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcMhL8/profile http://localhost:46291/getInfo.html) 05:03:38 INFO - PROCESS | 4849 | JavaScript error: , line 0: uncaught exception: undefined 05:03:38 INFO - PROCESS | 4849 | __metrics Screen width/height:1600/1200 05:03:38 INFO - PROCESS | 4849 | colorDepth:24 05:03:38 INFO - PROCESS | 4849 | Browser inner width/height: 1024/697 05:03:38 INFO - PROCESS | 4849 | __metrics 05:03:39 INFO - PROCESS | 4849 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:03:39 INFO - PROCESS | 4849 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:40 INFO - TEST-INFO | 4849: exit 0 05:03:40 INFO - Browser initialized. 05:03:40 INFO - Running cycle 1/1 for kraken test... 05:03:40 INFO - TEST-INFO | started process 4926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdcMhL8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:52 INFO - PROCESS | 4926 | RSS: Main: 159817728 05:03:52 INFO - PROCESS | 4926 | 05:03:55 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46291/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:56 INFO - PROCESS | 4926 | RSS: Main: 215302144 05:03:56 INFO - PROCESS | 4926 | 05:03:59 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46291/tests/kraken/driver.html?testName=audio-dft) 05:03:59 INFO - PROCESS | 4926 | RSS: Main: 189042688 05:03:59 INFO - PROCESS | 4926 | 05:04:02 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46291/tests/kraken/driver.html?testName=audio-fft) 05:04:03 INFO - PROCESS | 4926 | RSS: Main: 272142336 05:04:03 INFO - PROCESS | 4926 | 05:04:05 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46291/tests/kraken/driver.html?testName=audio-oscillator) 05:04:06 INFO - PROCESS | 4926 | RSS: Main: 182763520 05:04:06 INFO - PROCESS | 4926 | 05:04:08 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:09 INFO - PROCESS | 4926 | RSS: Main: 186929152 05:04:09 INFO - PROCESS | 4926 | 05:04:12 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46291/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:13 INFO - PROCESS | 4926 | RSS: Main: 222887936 05:04:13 INFO - PROCESS | 4926 | 05:04:16 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46291/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:17 INFO - PROCESS | 4926 | RSS: Main: 217460736 05:04:17 INFO - PROCESS | 4926 | 05:04:20 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46291/tests/kraken/driver.html?testName=json-parse-financial) 05:04:20 INFO - PROCESS | 4926 | RSS: Main: 220651520 05:04:20 INFO - PROCESS | 4926 | 05:04:22 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:22 INFO - PROCESS | 4926 | RSS: Main: 186187776 05:04:22 INFO - PROCESS | 4926 | 05:04:24 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:25 INFO - PROCESS | 4926 | RSS: Main: 190652416 05:04:25 INFO - PROCESS | 4926 | 05:04:27 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:28 INFO - PROCESS | 4926 | RSS: Main: 195760128 05:04:28 INFO - PROCESS | 4926 | 05:04:31 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:04:31 INFO - PROCESS | 4926 | RSS: Main: 190148608 05:04:31 INFO - PROCESS | 4926 | 05:04:34 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:04:35 INFO - PROCESS | 4926 | RSS: Main: 194469888 05:04:35 INFO - PROCESS | 4926 | 05:04:36 INFO - PROCESS | 4926 | Cycle 1(1): loaded http://localhost:46291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46291/tests/kraken/driver.html?testName=ai-astar) 05:04:37 INFO - PROCESS | 4926 | RSS: Main: 244707328 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | __start_tp_report 05:04:37 INFO - PROCESS | 4926 | _x_x_mozilla_page_load 05:04:37 INFO - PROCESS | 4926 | _x_x_mozilla_page_load_details 05:04:37 INFO - PROCESS | 4926 | |i|pagename|runs| 05:04:37 INFO - PROCESS | 4926 | |0;ai-astar;104;114;113;114;114;112;114;113;113;113 05:04:37 INFO - PROCESS | 4926 | |1;audio-beat-detection;147;121;131;182;124;124;149;124;157;121 05:04:37 INFO - PROCESS | 4926 | |2;audio-dft;162;162;161;160;163;163;163;164;161;160 05:04:37 INFO - PROCESS | 4926 | |3;audio-fft;75;76;75;127;77;76;75;75;110;77 05:04:37 INFO - PROCESS | 4926 | |4;audio-oscillator;86;86;113;86;85;86;128;85;85;135 05:04:37 INFO - PROCESS | 4926 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 05:04:37 INFO - PROCESS | 4926 | |6;imaging-darkroom;146;146;147;146;146;145;147;147;146;146 05:04:37 INFO - PROCESS | 4926 | |7;imaging-desaturate;95;94;95;94;95;95;95;95;95;95 05:04:37 INFO - PROCESS | 4926 | |8;json-parse-financial;62;61;61;61;66;63;61;62;61;61 05:04:37 INFO - PROCESS | 4926 | |9;json-stringify-tinderbox;65;66;64;66;66;66;65;67;68;66 05:04:37 INFO - PROCESS | 4926 | |10;stanford-crypto-aes;80;79;78;80;81;84;85;84;79;88 05:04:37 INFO - PROCESS | 4926 | |11;stanford-crypto-ccm;131;137;130;137;128;125;128;128;211;139 05:04:37 INFO - PROCESS | 4926 | |12;stanford-crypto-pbkdf2;166;165;165;163;170;167;166;165;167;170 05:04:37 INFO - PROCESS | 4926 | |13;stanford-crypto-sha256-iterative;68;67;67;68;66;65;68;68;67;67 05:04:37 INFO - PROCESS | 4926 | __end_tp_report 05:04:37 INFO - PROCESS | 4926 | __start_cc_report 05:04:37 INFO - PROCESS | 4926 | _x_x_mozilla_cycle_collect,1918 05:04:37 INFO - PROCESS | 4926 | __end_cc_report 05:04:37 INFO - PROCESS | 4926 | __startTimestamp1469793877215__endTimestamp 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | ------- Summary: start ------- 05:04:37 INFO - PROCESS | 4926 | Number of tests: 14 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:3.03 (2.7%) stddev-sans-first:0.71 05:04:37 INFO - PROCESS | 4926 | Values: 104.0 114.0 113.0 114.0 114.0 112.0 114.0 113.0 113.0 113.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:139.00 stddev:20.31 (14.6%) stddev-sans-first:21.28 05:04:37 INFO - PROCESS | 4926 | Values: 147.0 121.0 131.0 182.0 124.0 124.0 149.0 124.0 157.0 121.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.45 05:04:37 INFO - PROCESS | 4926 | Values: 162.0 162.0 161.0 160.0 163.0 163.0 163.0 164.0 161.0 160.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#3] audio-fft Cycles:10 Average:84.30 Median:75.50 stddev:18.48 (24.5%) stddev-sans-first:19.29 05:04:37 INFO - PROCESS | 4926 | Values: 75.0 76.0 75.0 127.0 77.0 76.0 75.0 75.0 110.0 77.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.50 stddev:19.93 (23.3%) stddev-sans-first:20.70 05:04:37 INFO - PROCESS | 4926 | Values: 86.0 86.0 113.0 86.0 85.0 86.0 128.0 85.0 85.0 135.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:04:37 INFO - PROCESS | 4926 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:04:37 INFO - PROCESS | 4926 | Values: 146.0 146.0 147.0 146.0 146.0 145.0 147.0 147.0 146.0 146.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:04:37 INFO - PROCESS | 4926 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:61.50 stddev:1.60 (2.6%) stddev-sans-first:1.69 05:04:37 INFO - PROCESS | 4926 | Values: 62.0 61.0 61.0 61.0 66.0 63.0 61.0 62.0 61.0 61.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 05:04:37 INFO - PROCESS | 4926 | Values: 65.0 66.0 64.0 66.0 66.0 66.0 65.0 67.0 68.0 66.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:3.26 (4.0%) stddev-sans-first:3.39 05:04:37 INFO - PROCESS | 4926 | Values: 80.0 79.0 78.0 80.0 81.0 84.0 85.0 84.0 79.0 88.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:134.00 stddev:25.59 (19.1%) stddev-sans-first:26.96 05:04:37 INFO - PROCESS | 4926 | Values: 131.0 137.0 130.0 137.0 128.0 125.0 128.0 128.0 211.0 139.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.50 stddev:2.22 (1.3%) stddev-sans-first:2.35 05:04:37 INFO - PROCESS | 4926 | Values: 166.0 165.0 165.0 163.0 170.0 167.0 166.0 165.0 167.0 170.0 05:04:37 INFO - PROCESS | 4926 | 05:04:37 INFO - PROCESS | 4926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:0.99 (1.5%) stddev-sans-first:1.00 05:04:37 INFO - PROCESS | 4926 | Values: 68.0 67.0 67.0 68.0 66.0 65.0 68.0 68.0 67.0 67.0 05:04:37 INFO - PROCESS | 4926 | -------- Summary: end -------- 05:04:37 INFO - PROCESS | 4926 | 05:04:38 INFO - TEST-INFO | 4926: exit 0 05:04:38 INFO - TEST-OK | kraken | took 63852ms 05:04:38 INFO - SUITE-END | took 1183s 05:04:38 INFO - Completed test suite (00:19:43) 05:04:38 INFO - javascript benchmark 05:04:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2645.391559941212, 2645.5370310195717, 2674.1175412114003, 2686.1001564475887, 2691.031228757647, 4567.063751930855, 4651.837185698493, 4729.172394830904, 4792.281157826328, 4799.016201678652, 4699.694519856215, 4731.858044258669, 4747.121782470245, 4772.73749943753, 4814.66297359185, 4340.066885619591, 4358.171947330013, 4424.646028317727, 4478.820847166109, 4557.20248956433, 4480.48474425442, 4505.098980203972, 4520.412346394981, 4536.024754677744, 4543.273076307792, 4294.63495602871, 4329.891752706176, 4337.934930976006, 4357.760323182224, 4410.75740834254, 4380.18966491197, 4388.89027774305, 4414.602685758297, 4415.977920110379, 4478.798454069574, 4449.844255451044, 4450.643948484146, 4456.465224173087, 4490.977545112253, 4504.256797628387, 4622.19111655459, 4696.178168820443, 4819.421669399694, 4833.975830120827, 4885.828995985159, 4993.850184494471, 5125.974370128163, 5127.66670166438, 5172.61205409592, 5179.715115668637, 5151.407588127376, 5158.9484105158845, 5199.350081239845, 5204.739763011872, 5219.608529360313, 4648.558386953234, 4694.0, 4729.314249433813, 4866.805327786884, 4869.172240719086, 5133.512316329943, 5178.97410512945, 5199.194124910645, 5207.1668533034535, 5212.478752124757, 4980.626453015966, 4981.90036199274, 5001.349824522861, 5012.749362531858, 5014.0974624567925, 4929.876753081202, 5028.044671512401, 5110.71891045996, 5122.231665250168, 5123.3339665843205, 5106.693598384109, 5115.232715092691, 5120.871978200575, 5137.5376216139975, 5149.871253218699, 5077.365329333833, 5080.872978175501, 5081.3140226069745, 5090.0583392072585, 5142.254373115878, 4182.811773470201, 4336.718113322624, 4340.978295108504, 4343.261645520206, 4386.188555117314, 3709.6104908984166, 3755.7183211259266, 3786.6213378662464, 3824.4072168813877, 3878.4764056852528, 4404.537523560044, 4413.426254586883, 4415.62467190286, 4419.160359531678, 4471.731696098244, 5116.606503602259, 5134.460881607378, 5143.254228136974, 5145.331106956071, 5180.326557547494, 4253.468316460442, 4341.305391137403, 4354.869353919387, 4386.583274588909, 4405.867823965286, 4585.679002469795, 4590.655700822452, 4607.642867819229, 4636.235021221461, 4637.443506779208, 4772.451168115642, 4777.689450185727, 4778.163821331323, 4791.401074865642, 4823.3729615149805, 4932.827351042696, 4979.526944940225, 5052.418971818288, 5104.770285337243, 5117.8464646060675, 4769.3084502746215, 4782.832600858953, 4794.2808578713475, 4798.880027999328, 4833.081714474239, 5022.673526220784, 5023.146065169003, 5023.497650234947, 5025.271335656383, 5079.3650793650795, 4952.826651067196, 5061.367329083864, 5071.340725705634, 5081.3902331718955, 5136.1268584340005, 4983.352164218629, 4983.700977941335, 4984.551390374883, 5024.0956627807345, 5037.823676171463, 4986.675866068694, 4993.875153121201, 4995.225740010304, 4998.100341938486, 5043.798248070183, 4714.764261786965, 4851.51484851512, 4867.464578896248, 4886.682365646222, 4943.332650092191, 5070.898582028265, 5072.289879416959, 5076.517730815566, 5089.821856235014, 5098.2862399263395, 4941.135301322326, 4947.876303092451, 4957.206846904478, 4961.231009193581, 5005.474425185449], "value": 4692.23655736365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.0070826407922, 571.9599628026037, 574.5862978655368, 581.5434883616362, 596.4900010491031, 29602.555961660564, 39604.40593391102, 40917.3862392064, 40953.59046409535, 45038.32442513357, 41312.38031429531, 41720.79139604298, 41758.0, 41817.37273940886, 41850.0, 7669.309762121422, 7845.64694588742, 7847.96076019622, 7849.8037549061155, 7852.136265010873, 7515.511491753018, 9764.853527197098, 9945.40327580344, 10022.496625506159, 10379.065884070433, 10091.444970526618, 10176.847347289797, 10183.236257280734, 10199.949000254988, 10204.642837500689, 10023.548940297667, 10046.346987445793, 10049.995000499928, 10077.546510406975, 10086.798264034678, 9889.90110098897, 9953.850692239623, 9960.850587241197, 9973.75065623358, 9976.201903847676, 39041.0, 39251.8037409814, 39364.40953385702, 39428.80285598582, 39450.80274598609, 2993.8652760625823, 3179.5071763876635, 3629.4192929131477, 3638.981805090984, 3711.3690672585726, 27551.586726199122, 29487.55768663472, 29562.70437295621, 29718.405631887243, 31140.0, 2766.7233276672373, 2821.1677555121287, 2821.252368122429, 2829.9292517687018, 2831.7593004594632, 257119.0, 258433.0, 260135.0, 260252.0, 260492.0, 55062.17406738902, 55335.44664553383, 55412.44587554153, 55471.44528554663, 55517.72241138769, 32981.0, 34057.48913766295, 34099.829500852335, 35812.283754324766, 35833.64166358355, 15149.469768558047, 15256.618584535254, 15299.46451874179, 15333.080015199124, 15336.003159794578, 10356.223283253787, 11358.545658173745, 11370.488328025258, 11448.885511144948, 11448.942755286336, 17622.91188544049, 18209.7268540972, 18222.36221732233, 18324.0, 18508.074596270402, 6708.865822683519, 6841.657917104125, 6853.17761868579, 7045.225025247219, 7073.681684324218, 794.8251384695358, 872.1801506583791, 929.6049179098856, 948.8292107420731, 961.4615815143542, 27966.72033279682, 28281.15156545307, 28437.72462510844, 28657.283567910552, 28899.277518061797, 951.2342564235719, 965.9034096590285, 967.5307475874196, 995.6117114325419, 1023.498485741996, 14877.0, 15022.173780441963, 15092.698146037017, 15301.846981530265, 15316.081035137928, 400904.0, 402238.0, 404625.0, 404683.0, 404989.0, 50228.49771502238, 50825.74587127041, 50895.491045089075, 51026.489735102914, 51046.48953510492, 1075.860138182047, 1124.7975364434317, 1130.2879186112696, 1178.1517307538559, 1210.8002179640437, 25863.741362586134, 29645.110646680634, 29686.367249801468, 30073.69926300709, 30115.698843012167, 44083.55916440795, 44680.32979505375, 44690.0, 44903.550964491245, 44940.0, 346614.0, 348484.0, 350389.0, 350822.0, 350905.0, 33905.66094339025, 34958.12604684903, 38789.806050969564, 43165.76256780817, 43590.78204609083, 43275.56724432841, 43606.34590481082, 43723.34414983841, 43782.0, 43796.12407751891, 36449.817750911076, 36516.45225321569, 36931.446028310136, 37334.066648332926, 38126.046848829, 36137.45793813042, 36924.815375922946, 37067.443988339655, 37307.81346093252, 37348.81325593355, 36395.818020909726, 36429.5360660944, 37027.444588330654, 37431.62568374391, 37772.24455510819, 31249.0, 33217.335653287286, 33570.328593427505, 33587.0, 34128.14679633029, 25005.0, 25732.742672573782, 27334.0, 27781.602761914335, 27944.02195923214], "value": 18271.027761962363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.91329124364535, 364.9963500364996, 368.4344531144692, 369.99260014799705, 374.32994939059085, 12697.809532857003, 13472.797908031387, 14476.5657030289, 17187.82812171878, 17218.483445496655, 16577.17114144291, 16730.498085057436, 16741.748873766905, 16799.328026878942, 16806.915965420158, 3947.684185265172, 5010.549050585447, 6206.534509911752, 6211.720472578722, 6325.493960483151, 6182.350853160421, 6184.8453788655415, 6197.194364732579, 6251.749930002818, 6265.937340626604, 6190.721417536199, 6190.78332258371, 6206.596571222879, 6211.596246243979, 6217.502599792028, 5945.16767652529, 5987.850303742442, 6130.2030736004035, 6167.938320616804, 6171.783987560436, 5332.706701131437, 5335.599830012726, 5336.51971322579, 5338.119210330291, 5341.4658534146665, 20045.298414555422, 20134.69797953032, 20318.187272509083, 20325.593488130155, 20477.283295084602, 1892.6025534637743, 1909.789923108457, 1925.7977912319145, 1967.1344608372412, 2389.295157928398, 12495.562655307021, 13281.667958301023, 13323.54322134651, 13509.527166549124, 13940.58178254654, 1447.833499147601, 1540.099042060396, 1549.4422008077083, 1561.36764610333, 1608.8230294667578, 43050.0, 54467.0, 68600.6569967152, 69551.0, 70430.64784676096, 9755.512224388753, 9806.411615303105, 9866.210703143732, 9908.900910990798, 10138.695839124837, 13728.313584320744, 13752.587422377344, 13754.65613359674, 13775.311234438239, 13802.447902083804, 7349.375303099297, 7511.737089201961, 7565.848683026308, 7665.386769058462, 7706.961465192639, 7081.752138675121, 7153.642317884085, 7198.532095413886, 7351.301626345488, 7362.631868406558, 6212.565120441616, 6264.9373506265265, 6300.117983482316, 6300.653464059521, 6315.747370105144, 1780.305680784495, 1807.2228941554995, 1813.519417354402, 1822.2437688359448, 1843.9446816595523, 796.307212724933, 809.906860711014, 835.5863847395578, 843.7974886027432, 872.3631748823394, 16865.241064152142, 17034.82965170357, 17343.0, 17822.55443613894, 17873.0, 843.7848348671049, 848.6435697007272, 870.4037734151999, 891.9241864441466, 942.2085448223526, 9451.054894510495, 9548.522573871278, 9625.278104142217, 9876.0, 10304.742381440374, 405682.0, 410026.0, 410622.0, 422642.0, 427245.0, 84582.5770871154, 86118.0, 86524.5673771627, 88021.5598922014, 88419.55790221137, 888.6356593796512, 896.5114012863005, 947.1191791633709, 950.4202436513721, 950.7623094226443, 15375.077495350315, 15767.68464630724, 16191.190440477694, 16278.43025494102, 16580.0880951544, 38299.70201787902, 38714.6128538711, 39298.80350598229, 39373.80313098416, 39684.0, 47762.522374777196, 51833.7408312956, 52264.47735522596, 52885.7355713219, 54662.45337546574, 7483.588402637907, 7579.658915348712, 7710.036245469317, 7749.41879359039, 7941.920580794349, 10364.326318789255, 10985.890141098806, 11088.279261847954, 11972.880271197177, 12204.938975305067, 9930.851037234592, 10025.348352357074, 10042.69871903844, 10152.441615710912, 10499.107575856138, 9841.557129929028, 9928.503574821374, 9977.650782222878, 10121.746956326151, 10759.085477734166, 10056.748581285234, 10157.644482443078, 10283.94858025705, 10546.947265263625, 10720.303180293256, 7321.341079302888, 7336.156342020522, 7368.4842061055215, 7461.291177338144, 7990.760277191694, 8183.631736571988, 9767.169790567597, 9926.652567160114, 10142.54358553852, 10549.156067514426], "value": 8469.939606440725, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1178.858536975563, 1313.7109835836113, 1363.2365875109936, 1405.7399381114487, 1715.4939292908591, 6747.56140850845, 7376.0, 7623.771286861389, 7629.504082234658, 7810.8047298817555, 7672.271134242252, 7724.845503089935, 7734.922650773505, 7741.9225807741905, 7743.0, 2167.945801354967, 2204.47092697753, 2205.2391924785925, 2207.0289072807914, 2208.712867327245, 2138.2302371146375, 2198.527316626925, 2199.263246812312, 2200.3618950504333, 2211.9778802212013, 2163.134746101564, 2185.825133989277, 2188.1794327127327, 2190.1348967157965, 2198.109765544949, 2108.2621082621113, 2108.546662467569, 2108.8523803333774, 2111.767705552388, 2112.0812446585633, 2065.297798748418, 2083.5207902182433, 2111.9788802111934, 2117.587070521249, 2124.2989813361555, 7627.199144089846, 7727.845443091107, 7746.225377462265, 7793.688252469894, 7798.064232292161, 4594.908101837945, 4754.168020596382, 4758.2386818108935, 4759.666823322369, 4764.0948219838465, 2771.362586605092, 2888.7400133988044, 2933.911982640524, 2937.735603795669, 2939.6031535742827, 893.263057977165, 899.6131663384742, 901.1349104859343, 902.5351943748974, 914.9313801464916, 10406.271560990734, 10528.842067368996, 10531.210159238088, 10548.20888433363, 10553.894461055368, 3845.4616353710503, 4011.7392369495888, 4145.0880806222585, 4149.854755083557, 4193.391958166048, 8308.626111824982, 8315.501069935823, 8321.41750077501, 8325.0, 8336.916630833735, 4568.497465278817, 4570.063137056895, 4573.222552166139, 4583.129205450954, 4584.3352713856975, 3626.5829429615405, 4102.405151253051, 4240.300350442204, 4271.209826182167, 4271.231178387858, 3383.120388698907, 3383.3064221834466, 3506.6142724300307, 3512.7892326459983, 3513.4554144107706, 1005.4520286443759, 1031.896810318962, 1037.4086770540719, 1039.0804138337626, 1040.7710303733168, 653.3433898931544, 823.8064054947083, 849.1890244816186, 849.8512760266929, 864.9091845356147, 5026.773795179226, 5113.769880355393, 5130.871208334161, 5266.1574148136115, 5312.2297266896085, 416.3151615592334, 423.33536347934063, 423.37129362896076, 423.5785393533454, 428.9383775156525, 3555.235624340779, 3561.394562924309, 3689.428138638462, 3754.8685795997008, 3778.2065766188857, 9397.718068457958, 9858.901410985942, 9870.753231169278, 9874.703758887244, 9880.209583233323, 9832.410055396698, 9842.852357214648, 9844.0, 9857.162141218078, 9865.161461275871, 7352.926470735224, 7424.888626670604, 7444.218357072429, 7455.85088298231, 7462.365698915653, 4980.626453016111, 5183.377994640668, 5224.1641337387355, 5229.294045303987, 5355.866103347447, 8812.823743525221, 8847.292216622784, 8949.105089490999, 8974.86537701922, 9050.909490905007, 9021.458712477272, 9123.361364704408, 9188.954055229948, 9199.770005749642, 9219.677311294072, 5824.592278540462, 6226.564140510302, 6444.613323200623, 6529.183852018497, 6534.346565343618, 7278.563286202845, 7533.773986780406, 7537.886931696139, 7570.9242907572425, 7580.279873412238, 6563.113979612691, 6583.63789991555, 6617.702203400762, 6723.831904202434, 6788.287229840796, 6527.738890444519, 6572.737090516326, 6595.208574971034, 6698.196216454056, 6700.6984685688285, 5955.821325360246, 6066.362082237682, 6067.848303792441, 6069.817905462666, 6076.210092687922, 4280.122574872206, 4403.273459879084, 4424.823007079681, 4432.29083346663, 4495.662825288051, 4320.265554855745, 4371.715838470489, 4376.671749618855, 4532.161550113239, 4602.056578401487], "value": 3985.6731236745636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.6120329360304, 293.40585314737655, 302.2639871911894, 306.1779123054597, 308.4217092950716, 4783.569478746912, 4792.880177995552, 4831.830885918994, 4832.130216561022, 4851.927221091686, 4778.856634300968, 4792.712437253767, 4793.257045158006, 4798.304245884345, 4889.633277504193, 3617.294627547623, 3711.1278849470355, 3723.385641369171, 3724.3854763963914, 3734.5705243897028, 3652.506911566931, 3695.353313170198, 3776.150366167618, 3779.2441511697634, 3795.3737633290475, 3744.6817020553285, 3756.774593524384, 3759.3308750786973, 3760.8683696070643, 3762.811859407019, 3531.823408829548, 3722.3671975764187, 3755.680767134797, 3776.1692427666007, 3813.103920578648, 3235.7573182011442, 3272.689094536015, 3282.097423208613, 3288.96711032889, 3293.386240742043, 4627.629789616823, 4649.442066951988, 4675.135100006476, 4729.290606409032, 4744.335792988984, 4094.344904815245, 4233.30150525166, 4254.7021708480415, 4263.7828329268605, 4273.97863010683, 4988.87527811804, 4990.3762029746285, 4991.450940396553, 4996.4503904570465, 4998.475464983178, 3594.478800573902, 3598.5681718193723, 3598.8047291152375, 3605.5132557104716, 3641.908952276214, 5064.392272927235, 5200.29795977542, 5220.477952204749, 5256.369235691704, 5257.8159764408065, 3638.7816730996224, 3652.6712595866497, 3653.4702468141973, 3666.578343490533, 3679.988003299114, 3685.875807878569, 3694.242680250542, 3705.2404257127764, 3710.276496083292, 3738.12154143776, 4200.6056547767475, 4229.6404805591255, 4231.703780735319, 4238.194742998882, 4239.703220774516, 4835.7427068961615, 4996.950030499721, 5011.448740638527, 5039.647224694236, 5039.866030143188, 1264.1151194164122, 1279.1238001968682, 1279.731256436159, 1281.4745954158936, 1281.8911641430282, 774.531408497862, 823.012385137837, 823.4030328012263, 829.2702421868717, 829.7261903571807, 4268.335349213809, 4375.978120109379, 4421.734695918255, 4483.005062747046, 4486.913585182906, 5162.432132465426, 5177.896442071137, 5186.792528298901, 5190.2214667800135, 5191.0, 4466.531014243523, 4471.530489298641, 4479.686421950432, 4484.686071974996, 4493.236149854532, 2628.4874449482168, 2718.3747738020365, 2734.5214587447117, 2734.740199681027, 2736.53478908586, 4863.781129849165, 4866.270059491105, 4869.639948435639, 4871.95128048715, 4881.633877459205, 5049.343585333957, 5195.922061169085, 5285.418603953639, 5286.092649043011, 5295.205719142083, 4847.175980083394, 4855.757212139379, 4865.878353041202, 4877.244027175793, 4877.463479017234, 5170.121079416433, 5170.948290517047, 5179.48205179479, 5183.315422487632, 5188.299579556711, 4932.4081110267, 5050.570701490415, 5092.301080427379, 5104.846854594368, 5121.359830021247, 4771.355866958055, 4804.423469183581, 4805.783739731791, 4826.8069277228515, 4834.105690447279, 3640.344737947195, 3653.70770338367, 3654.1230104775195, 3655.488231647518, 3659.6889264411757, 4977.203647416541, 5127.92308115386, 5137.229415587692, 5158.97420512895, 5162.9483705162465, 4909.435414927186, 4973.776180071978, 4994.875128121826, 4996.400431948189, 5008.824691135793, 4992.550670439678, 4994.850154495371, 4999.850004499871, 5000.874978125576, 5007.123753343078, 4681.765911704333, 4908.092002979461, 4915.623625384898, 4918.5573298403315, 4920.269250565971, 4768.594669453136, 4902.730349830794, 4985.326980857682, 5001.624878134227, 5052.621053420935, 4861.951380486292, 4891.315215869852, 4891.413030436371, 4891.877703057452, 4902.803887844446], "value": 3773.107568354003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.597781552913, 583.9503642190414, 602.7980626490125, 625.127946514612, 649.5777744466094, 11207.719807004829, 11862.051035917139, 11862.703432414182, 12232.143749937508, 12232.877671223285, 11750.647480575575, 11784.351860647683, 11867.643970680894, 11874.643760687171, 11877.0, 614.158602714281, 736.484460877388, 767.3170877918657, 775.4843029385452, 776.1423626892288, 765.1086484245847, 767.4090949968521, 767.57399643198, 767.8733009053527, 767.996160019202, 815.5310696349593, 815.5310696349593, 816.9387295952797, 817.1787353709543, 817.8159914019358, 806.8749343851713, 807.7657479330987, 807.9474834135792, 808.6159074439623, 809.2191035650567, 593.4984937727613, 594.6640148316187, 595.2618752746563, 595.3272801734056, 595.3421469276431, 10863.456827158689, 10906.454677266105, 10984.176186786022, 10985.890141098567, 10989.230753847234, 11645.6506304811, 11736.765264694659, 11824.290542567387, 12086.530498208895, 12198.268103913793, 9292.349535532516, 9494.382865113814, 9551.188149007343, 9580.90419095807, 9746.074122958307, 3090.5364195370876, 3098.5971823663003, 3111.984440077808, 3114.361555881039, 3121.9687803122133, 43153.0, 44420.77789611031, 51987.22019169753, 58450.41549584492, 59087.40912590905, 8732.0, 9204.079592040742, 9214.90785092154, 9397.436153830791, 9801.264905132144, 17187.31250749981, 17210.827891721172, 17210.91394543019, 17287.74068388975, 17301.653966920592, 6429.196350456193, 6455.580387274812, 6572.835679107965, 6684.598924064571, 6811.93188068113, 3366.040678406642, 3407.5059116428474, 3581.4448760442174, 3646.070252085701, 3649.361361761681, 2628.829126106797, 2721.972780272172, 2724.250831021485, 2730.2218867622632, 2735.261479400551, 487.97316147612224, 495.8462876508294, 499.9500049995044, 500.6670564074922, 508.84480233529126, 541.8482824809059, 585.2274997003999, 585.4730742331935, 598.1745191635515, 599.9130126131687, 7104.502684812013, 7115.1106111736035, 7470.215627359158, 7523.285287897641, 7631.0, 491.2739446524458, 519.857039314184, 540.3974568356255, 582.6766144789598, 590.271015296109, 3504.9123771905397, 3724.1806802503406, 3811.4663947047434, 3859.26673931952, 3863.497745293094, 93823.0617693828, 95279.0, 96792.35284118741, 97159.0, 99135.0, 61570.38429615736, 69880.0, 79113.0, 79461.60269198733, 79509.0, 70693.0, 72049.27950720531, 75407.86888196682, 76031.61984190154, 77221.61389193131, 7934.722284720007, 8120.350371970347, 8235.588220589067, 8304.543250121302, 8399.202075802788, 43569.78215109031, 43958.0, 45149.0, 45866.541334587564, 45999.0, 59526.70236648789, 59571.70214148902, 65139.348606513326, 67264.0, 67960.0, 10786.784264314827, 10809.67570972872, 10843.945780271048, 10942.617008404668, 11248.325100493996, 11680.240784348991, 11879.406029698308, 11898.643040708792, 11935.880641193477, 11968.940155299168, 10871.891281087088, 11176.776464470828, 11265.549378025114, 11526.366049867001, 11601.477933492844, 10692.411917344622, 10697.411642359433, 11143.888561114285, 11154.274972126786, 11436.256643318158, 10866.891331086588, 10900.618478353219, 11403.543858245908, 11611.767764644828, 11628.418579070843, 9234.215091717278, 9267.44395336282, 9410.200132988499, 9549.283803714889, 9553.713388598353, 8643.654253830027, 8867.778305542413, 9127.589258483516, 9159.77100572491, 9712.368696034735], "value": 6193.604716162238, "unit": "score"}], "name": "dromaeo_css", "value": 6383.1764184861795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 114.0, 114.0, 112.0, 114.0, 113.0, 113.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 131.0, 182.0, 124.0, 124.0, 149.0, 124.0, 157.0, 121.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 163.0, 163.0, 163.0, 164.0, 161.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 127.0, 77.0, 76.0, 75.0, 75.0, 110.0, 77.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 113.0, 86.0, 85.0, 86.0, 128.0, 85.0, 85.0, 135.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 66.0, 63.0, 61.0, 62.0, 61.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 66.0, 66.0, 66.0, 65.0, 67.0, 68.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 80.0, 81.0, 84.0, 85.0, 84.0, 79.0, 88.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 130.0, 137.0, 128.0, 125.0, 128.0, 128.0, 211.0, 139.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 165.0, 163.0, 170.0, 167.0, 166.0, 165.0, 167.0, 170.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 66.0, 65.0, 68.0, 68.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1534.3999999999999, "alertThreshold": 2.0}]} 05:04:38 INFO - Return code: 0 05:04:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:04:38 INFO - # TBPL SUCCESS # 05:04:38 INFO - Running post-action listener: _resource_record_post_action 05:04:38 INFO - [mozharness: 2016-07-29 12:04:38.531144Z] Finished run-tests step (success) 05:04:38 INFO - Running post-run listener: _resource_record_post_run 05:04:38 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548212736; Read time: 16; Write time: 593000 05:04:38 INFO - TinderboxPrint: CPU usage
13.0% 05:04:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:04:38 INFO - TinderboxPrint: I/O write bytes / time
548,212,736 / 593,000 05:04:38 INFO - TinderboxPrint: CPU idle
8,332.6 (87.0%) 05:04:38 INFO - TinderboxPrint: CPU user
1,197.7 (12.5%) 05:04:38 INFO - TinderboxPrint: Swap in / out
0 / 0 05:04:38 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259248128; Read time: 0; Write time: 314836 05:04:38 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288964608; Read time: 16; Write time: 278164 05:04:39 INFO - Running post-run listener: _upload_blobber_files 05:04:39 INFO - Blob upload gear active. 05:04:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:04:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:04:39 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'] 05:04:39 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 05:04:39 INFO - (blobuploader) - INFO - Open directory for files ... 05:04:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:04:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:04:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:43 INFO - (blobuploader) - INFO - Done attempting. 05:04:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:04:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:04:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:44 INFO - (blobuploader) - INFO - Done attempting. 05:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:04:45 INFO - (blobuploader) - INFO - Done attempting. 05:04:45 INFO - (blobuploader) - INFO - Iteration through files over. 05:04:45 INFO - Return code: 0 05:04:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:04:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:04:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d71b50ca9ae6ca12e4a3023f168c65f27b55c380ad5305c464a2670b977e1c759675ec563a2a9a186eddb8c38e5ea4473b2e1576c7b31fd78ba129a0d95b4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14fcf07586dec1c5c1e078fa6c5231cbfb554afe0be5a039b2201a87a23d986052625f0549e0adb8d3ebe71fccc8d60544eaa3216f8912b5c8bd9dab53d49b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997c4897c965671ad2978f2db818db7036dff1a8bbdf40f1770625236d88fd16e9df1ca9cd5f6d0b181cab0e8b77722aa33273c1d1a2d3d5b8e1705d48d940f7"} 05:04:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:04:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:04:45 INFO - Contents: 05:04:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d71b50ca9ae6ca12e4a3023f168c65f27b55c380ad5305c464a2670b977e1c759675ec563a2a9a186eddb8c38e5ea4473b2e1576c7b31fd78ba129a0d95b4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14fcf07586dec1c5c1e078fa6c5231cbfb554afe0be5a039b2201a87a23d986052625f0549e0adb8d3ebe71fccc8d60544eaa3216f8912b5c8bd9dab53d49b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997c4897c965671ad2978f2db818db7036dff1a8bbdf40f1770625236d88fd16e9df1ca9cd5f6d0b181cab0e8b77722aa33273c1d1a2d3d5b8e1705d48d940f7"} 05:04:45 INFO - Running post-run listener: copy_logs_to_upload_dir 05:04:45 INFO - Copying logs to upload dir... 05:04:45 INFO - mkdir: /builds/slave/test/build/upload/logs 05:04:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.786246 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-29 05:04:44.898412) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 05:04:44.902639) ========= 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=fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199 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/3d71b50ca9ae6ca12e4a3023f168c65f27b55c380ad5305c464a2670b977e1c759675ec563a2a9a186eddb8c38e5ea4473b2e1576c7b31fd78ba129a0d95b4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14fcf07586dec1c5c1e078fa6c5231cbfb554afe0be5a039b2201a87a23d986052625f0549e0adb8d3ebe71fccc8d60544eaa3216f8912b5c8bd9dab53d49b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997c4897c965671ad2978f2db818db7036dff1a8bbdf40f1770625236d88fd16e9df1ca9cd5f6d0b181cab0e8b77722aa33273c1d1a2d3d5b8e1705d48d940f7"} build_url:https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/b7xyyZkeRxSTm8HPElGQbw/artifacts/public/build/firefox-50.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/3d71b50ca9ae6ca12e4a3023f168c65f27b55c380ad5305c464a2670b977e1c759675ec563a2a9a186eddb8c38e5ea4473b2e1576c7b31fd78ba129a0d95b4f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14fcf07586dec1c5c1e078fa6c5231cbfb554afe0be5a039b2201a87a23d986052625f0549e0adb8d3ebe71fccc8d60544eaa3216f8912b5c8bd9dab53d49b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/997c4897c965671ad2978f2db818db7036dff1a8bbdf40f1770625236d88fd16e9df1ca9cd5f6d0b181cab0e8b77722aa33273c1d1a2d3d5b8e1705d48d940f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 05:04:44.932000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:04:44.932344) ========= 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=fa44defc139c4ba8574fe040000001db-1469792475.107915-1820533199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 05:04:45.014141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 05:04:45.014455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 05:04:45.014757) ========= ========= Total master_lag: 0.18 =========