builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1459625832.36 results: success (0) buildid: 20160402110310 builduid: aaa2080f7d6849ceb6fb73b21266223e revision: 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.360864) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.361262) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.361544) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006449 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.392933) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.393209) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.429288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.429549) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.479057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.479354) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.479720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.479989) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-02 12:37:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 90.9M=0s 2016-04-02 12:37:13 (90.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099224 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.592387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.592704) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015071 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:12.641987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-02 12:37:12.642295) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 --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 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 --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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-02 12:37:13,197 truncating revision to first 12 chars 2016-04-02 12:37:13,197 Setting DEBUG logging. 2016-04-02 12:37:13,198 attempt 1/10 2016-04-02 12:37:13,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1f8433e85420?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-02 12:37:14,228 unpacking tar archive at: fx-team-1f8433e85420/testing/mozharness/ program finished with exit code 0 elapsedTime=1.278897 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-02 12:37:13.933890) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:13.934227) ========= echo 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1f8433e85420fc2156ac0dbd68186cef5cf1ebe8'] 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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 program finished with exit code 0 elapsedTime=0.004683 script_repo_revision: '1f8433e85420fc2156ac0dbd68186cef5cf1ebe8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:13.986920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:13.987217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 12:37:13.997924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-02 12:37:13.998339) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:37:14 INFO - MultiFileLogger online at 20160402 12:37:14 in /builds/slave/test 12:37:14 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 12:37:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:37:14 INFO - {'append_to_log': False, 12:37:14 INFO - 'base_work_dir': '/builds/slave/test', 12:37:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:37:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:37:14 INFO - 'branch': 'Fx-Team-Non-PGO', 12:37:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:37:14 INFO - 'config_files': ('talos/linux_config.py',), 12:37:14 INFO - 'default_actions': ('clobber', 12:37:14 INFO - 'read-buildbot-config', 12:37:14 INFO - 'download-and-extract', 12:37:14 INFO - 'populate-webroot', 12:37:14 INFO - 'create-virtualenv', 12:37:14 INFO - 'install', 12:37:14 INFO - 'run-tests'), 12:37:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:37:14 INFO - 'download_minidump_stackwalk': True, 12:37:14 INFO - 'download_symbols': 'ondemand', 12:37:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:37:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:37:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:37:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:37:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:37:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:37:14 INFO - 'installer_path': 'installer.exe', 12:37:14 INFO - 'log_level': 'info', 12:37:14 INFO - 'log_name': 'talos', 12:37:14 INFO - 'log_to_console': True, 12:37:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:37:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:37:14 INFO - 'opt_config_files': (), 12:37:14 INFO - 'pip_index': False, 12:37:14 INFO - 'sps_profile': False, 12:37:14 INFO - 'sps_profile_interval': 0, 12:37:14 INFO - 'suite': 'dromaeojs', 12:37:14 INFO - 'system_bits': '32', 12:37:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:37:14 INFO - 'title': 'talos-linux64-ix-007', 12:37:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:37:14 INFO - 'use_talos_json': True, 12:37:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:37:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:37:14 INFO - 'work_dir': 'build'} 12:37:14 INFO - ##### 12:37:14 INFO - ##### Running clobber step. 12:37:14 INFO - ##### 12:37:14 INFO - Running pre-action listener: _resource_record_pre_action 12:37:14 INFO - Running main action method: clobber 12:37:14 INFO - rmtree: /builds/slave/test/build 12:37:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:37:15 INFO - Running post-action listener: _resource_record_post_action 12:37:15 INFO - ##### 12:37:15 INFO - ##### Running read-buildbot-config step. 12:37:15 INFO - ##### 12:37:15 INFO - Running pre-action listener: _resource_record_pre_action 12:37:15 INFO - Running main action method: read_buildbot_config 12:37:15 INFO - Using buildbot properties: 12:37:15 INFO - { 12:37:15 INFO - "project": "", 12:37:15 INFO - "product": "firefox", 12:37:15 INFO - "script_repo_revision": "production", 12:37:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:37:15 INFO - "repository": "", 12:37:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:37:15 INFO - "buildid": "20160402110310", 12:37:15 INFO - "pgo_build": "False", 12:37:15 INFO - "basedir": "/builds/slave/test", 12:37:15 INFO - "buildnumber": 2745, 12:37:15 INFO - "slavename": "talos-linux64-ix-007", 12:37:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:37:15 INFO - "platform": "ubuntu64_hw", 12:37:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:37:15 INFO - "branch": "fx-team", 12:37:15 INFO - "repo_path": "integration/fx-team", 12:37:15 INFO - "revision": "1f8433e85420fc2156ac0dbd68186cef5cf1ebe8", 12:37:15 INFO - "stage_platform": "linux64", 12:37:15 INFO - "builduid": "aaa2080f7d6849ceb6fb73b21266223e", 12:37:15 INFO - "slavebuilddir": "test" 12:37:15 INFO - } 12:37:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:37:15 INFO - Running post-action listener: _resource_record_post_action 12:37:15 INFO - ##### 12:37:15 INFO - ##### Running download-and-extract step. 12:37:15 INFO - ##### 12:37:15 INFO - Running pre-action listener: _resource_record_pre_action 12:37:15 INFO - Running main action method: download_and_extract 12:37:15 INFO - mkdir: /builds/slave/test/build/tests 12:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:15 INFO - https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:37:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:37:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:37:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:37:17 INFO - Downloaded 1361 bytes. 12:37:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:37:17 INFO - Using the following test package requirements: 12:37:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:37:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:37:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:37:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'jsshell-linux-x86_64.zip'], 12:37:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:37:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:37:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:37:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:37:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:37:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:37:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:37:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:17 INFO - https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:37:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:37:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:37:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:37:19 INFO - Downloaded 22125456 bytes. 12:37:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:37:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:37:20 INFO - Return code: 0 12:37:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:20 INFO - https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:37:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:37:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:37:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:37:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:37:22 INFO - Downloaded 22125456 bytes. 12:37:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:37:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:37:23 INFO - Return code: 0 12:37: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')]} 12:37:23 INFO - https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:37:25 INFO - Downloaded 10847584 bytes. 12:37:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:37:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:37:25 INFO - Return code: 0 12:37:25 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')]} 12:37:25 INFO - https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:37:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:37:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:37:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:37:26 INFO - Downloaded 54088970 bytes. 12:37:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:37:26 INFO - mkdir: /builds/slave/test/properties 12:37:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:37:26 INFO - Writing to file /builds/slave/test/properties/build_url 12:37:26 INFO - Contents: 12:37:26 INFO - build_url:https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:37:28 INFO - Running post-action listener: _resource_record_post_action 12:37:28 INFO - Running post-action listener: set_extra_try_arguments 12:37:28 INFO - ##### 12:37:28 INFO - ##### Running populate-webroot step. 12:37:28 INFO - ##### 12:37:28 INFO - Running pre-action listener: _resource_record_pre_action 12:37:28 INFO - Running main action method: populate_webroot 12:37:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:37:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:37:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:37:28 INFO - '--tppagecycles', 12:37:28 INFO - '7'], 12:37:28 INFO - 'tests': ['tsvgm']}}, 12:37:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:37:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:37:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:37:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:37:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:37:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:37:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'tests': ['damp', 'tps']}, 12:37:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['damp', 'tps']}, 12:37:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:37:28 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['dromaeo_dom']}, 12:37:28 INFO - 'other': {'tests': ['a11yr', 12:37:28 INFO - 'ts_paint', 12:37:28 INFO - 'tpaint', 12:37:28 INFO - 'sessionrestore', 12:37:28 INFO - 'sessionrestore_no_auto_restore', 12:37:28 INFO - 'tabpaint']}, 12:37:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['a11yr', 12:37:28 INFO - 'ts_paint', 12:37:28 INFO - 'tpaint', 12:37:28 INFO - 'sessionrestore', 12:37:28 INFO - 'sessionrestore_no_auto_restore', 12:37:28 INFO - 'tabpaint']}, 12:37:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['a11yr', 12:37:28 INFO - 'ts_paint', 12:37:28 INFO - 'tpaint', 12:37:28 INFO - 'sessionrestore', 12:37:28 INFO - 'sessionrestore_no_auto_restore', 12:37:28 INFO - 'tabpaint']}, 12:37:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['a11yr', 12:37:28 INFO - 'ts_paint', 12:37:28 INFO - 'tpaint', 12:37:28 INFO - 'sessionrestore', 12:37:28 INFO - 'sessionrestore_no_auto_restore', 12:37:28 INFO - 'tabpaint']}, 12:37:28 INFO - 'other_l64': {'tests': ['a11yr', 12:37:28 INFO - 'ts_paint', 12:37:28 INFO - 'tpaint', 12:37:28 INFO - 'sessionrestore', 12:37:28 INFO - 'sessionrestore_no_auto_restore', 12:37:28 INFO - 'tabpaint']}, 12:37:28 INFO - 'other_nol64': {'tests': ['a11yr', 12:37:28 INFO - 'ts_paint', 12:37:28 INFO - 'tpaint', 12:37:28 INFO - 'sessionrestore', 12:37:28 INFO - 'sessionrestore_no_auto_restore', 12:37:28 INFO - 'tabpaint']}, 12:37:28 INFO - 'svgr': {'tests': ['tsvgx', 12:37:28 INFO - 'tsvgr_opacity', 12:37:28 INFO - 'tart', 12:37:28 INFO - 'tscrollx', 12:37:28 INFO - 'cart']}, 12:37:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['tsvgx', 12:37:28 INFO - 'tsvgr_opacity', 12:37:28 INFO - 'tart', 12:37:28 INFO - 'tscrollx', 12:37:28 INFO - 'cart']}, 12:37:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'tests': ['tp5o']}, 12:37:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'talos_options': ['--e10s'], 12:37:28 INFO - 'tests': ['tp5o']}, 12:37:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'talos_options': ['--xperf_path', 12:37:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:37:28 INFO - 'tests': ['tp5n']}, 12:37:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:37:28 INFO - 'talos_options': ['--e10s', 12:37:28 INFO - '--xperf_path', 12:37:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:37:28 INFO - 'tests': ['tp5n']}}, 12:37:28 INFO - 'talos.zip': {'path': '', 12:37:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:37:28 INFO - Running post-action listener: _resource_record_post_action 12:37:28 INFO - ##### 12:37:28 INFO - ##### Running create-virtualenv step. 12:37:28 INFO - ##### 12:37:28 INFO - Running pre-action listener: _resource_record_pre_action 12:37:28 INFO - Running main action method: create_virtualenv 12:37:28 INFO - Creating virtualenv /builds/slave/test/build/venv 12:37:28 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 12:37:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:37:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:37:28 INFO - Using real prefix '/usr' 12:37:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:37:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:37:30 INFO - Installing pip.................done. 12:37:30 INFO - Return code: 0 12:37:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:37: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')]} 12:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37: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')]} 12:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:37:30 INFO - Using env: {'DISPLAY': ':0', 12:37:30 INFO - 'HOME': '/home/cltbld', 12:37:30 INFO - 'LANG': 'en_US.UTF-8', 12:37:30 INFO - 'LANGUAGE': 'en_US:en', 12:37:30 INFO - 'LOGNAME': 'cltbld', 12:37:30 INFO - 'MAIL': '/var/mail/cltbld', 12:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:30 INFO - 'MOZ_NO_REMOTE': '1', 12:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:30 INFO - 'NO_EM_RESTART': '1', 12:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:30 INFO - 'PWD': '/builds/slave/test', 12:37:30 INFO - 'SHELL': '/bin/bash', 12:37:30 INFO - 'SHLVL': '1', 12:37:30 INFO - 'TERM': 'linux', 12:37:30 INFO - 'TMOUT': '86400', 12:37:30 INFO - 'USER': 'cltbld', 12:37:30 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:30 INFO - '_': '/tools/buildbot/bin/python'} 12:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:30 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 12:37:30 INFO - Cleaning up... 12:37:30 INFO - Return code: 0 12:37:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:37: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')]} 12:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37: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')]} 12:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:37:30 INFO - Using env: {'DISPLAY': ':0', 12:37:30 INFO - 'HOME': '/home/cltbld', 12:37:30 INFO - 'LANG': 'en_US.UTF-8', 12:37:30 INFO - 'LANGUAGE': 'en_US:en', 12:37:30 INFO - 'LOGNAME': 'cltbld', 12:37:30 INFO - 'MAIL': '/var/mail/cltbld', 12:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:30 INFO - 'MOZ_NO_REMOTE': '1', 12:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:30 INFO - 'NO_EM_RESTART': '1', 12:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:30 INFO - 'PWD': '/builds/slave/test', 12:37:30 INFO - 'SHELL': '/bin/bash', 12:37:30 INFO - 'SHLVL': '1', 12:37:30 INFO - 'TERM': 'linux', 12:37:30 INFO - 'TMOUT': '86400', 12:37:30 INFO - 'USER': 'cltbld', 12:37:30 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:30 INFO - '_': '/tools/buildbot/bin/python'} 12:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:31 INFO - Downloading/unpacking psutil>=0.7.1 12:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:37:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:37:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:37:33 INFO - Installing collected packages: psutil 12:37:33 INFO - Running setup.py install for psutil 12:37:33 INFO - building 'psutil._psutil_linux' extension 12:37:33 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 12:37:33 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 12:37:33 INFO - building 'psutil._psutil_posix' extension 12:37:33 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 12:37:33 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 12:37:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:37:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:37:33 INFO - Successfully installed psutil 12:37:33 INFO - Cleaning up... 12:37:33 INFO - Return code: 0 12:37:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:37: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')]} 12:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37: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')]} 12:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:37:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:37:33 INFO - Using env: {'DISPLAY': ':0', 12:37:33 INFO - 'HOME': '/home/cltbld', 12:37:33 INFO - 'LANG': 'en_US.UTF-8', 12:37:33 INFO - 'LANGUAGE': 'en_US:en', 12:37:33 INFO - 'LOGNAME': 'cltbld', 12:37:33 INFO - 'MAIL': '/var/mail/cltbld', 12:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:33 INFO - 'MOZ_NO_REMOTE': '1', 12:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:33 INFO - 'NO_EM_RESTART': '1', 12:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:33 INFO - 'PWD': '/builds/slave/test', 12:37:33 INFO - 'SHELL': '/bin/bash', 12:37:33 INFO - 'SHLVL': '1', 12:37:33 INFO - 'TERM': 'linux', 12:37:33 INFO - 'TMOUT': '86400', 12:37:33 INFO - 'USER': 'cltbld', 12:37:33 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:33 INFO - '_': '/tools/buildbot/bin/python'} 12:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:37:35 INFO - Installing collected packages: mozsystemmonitor 12:37:35 INFO - Running setup.py install for mozsystemmonitor 12:37:35 INFO - Successfully installed mozsystemmonitor 12:37:35 INFO - Cleaning up... 12:37:35 INFO - Return code: 0 12:37:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:37:35 INFO - Using env: {'DISPLAY': ':0', 12:37:35 INFO - 'HOME': '/home/cltbld', 12:37:35 INFO - 'LANG': 'en_US.UTF-8', 12:37:35 INFO - 'LANGUAGE': 'en_US:en', 12:37:35 INFO - 'LOGNAME': 'cltbld', 12:37:35 INFO - 'MAIL': '/var/mail/cltbld', 12:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:35 INFO - 'MOZ_NO_REMOTE': '1', 12:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:35 INFO - 'NO_EM_RESTART': '1', 12:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:35 INFO - 'PWD': '/builds/slave/test', 12:37:35 INFO - 'SHELL': '/bin/bash', 12:37:35 INFO - 'SHLVL': '1', 12:37:35 INFO - 'TERM': 'linux', 12:37:35 INFO - 'TMOUT': '86400', 12:37:35 INFO - 'USER': 'cltbld', 12:37:35 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:35 INFO - '_': '/tools/buildbot/bin/python'} 12:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:36 INFO - Downloading/unpacking blobuploader==1.2.4 12:37:36 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 12:37:36 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 12:37:36 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 12:37:36 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 12:37:36 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 12:37:36 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 12:37:37 INFO - Downloading blobuploader-1.2.4.tar.gz 12:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:37:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:37:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:38 INFO - Downloading docopt-0.6.1.tar.gz 12:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:37:38 INFO - Installing collected packages: blobuploader, requests, docopt 12:37:38 INFO - Running setup.py install for blobuploader 12:37:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:37:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:37:38 INFO - Running setup.py install for requests 12:37:39 INFO - Running setup.py install for docopt 12:37:39 INFO - Successfully installed blobuploader requests docopt 12:37:39 INFO - Cleaning up... 12:37:39 INFO - Return code: 0 12:37:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:39 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 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:39 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 12:37:39 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 12:37:39 INFO - Using env: {'DISPLAY': ':0', 12:37:39 INFO - 'HOME': '/home/cltbld', 12:37:39 INFO - 'LANG': 'en_US.UTF-8', 12:37:39 INFO - 'LANGUAGE': 'en_US:en', 12:37:39 INFO - 'LOGNAME': 'cltbld', 12:37:39 INFO - 'MAIL': '/var/mail/cltbld', 12:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:39 INFO - 'MOZ_NO_REMOTE': '1', 12:37:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:39 INFO - 'NO_EM_RESTART': '1', 12:37:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:39 INFO - 'PWD': '/builds/slave/test', 12:37:39 INFO - 'SHELL': '/bin/bash', 12:37:39 INFO - 'SHLVL': '1', 12:37:39 INFO - 'TERM': 'linux', 12:37:39 INFO - 'TMOUT': '86400', 12:37:39 INFO - 'USER': 'cltbld', 12:37:39 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:39 INFO - '_': '/tools/buildbot/bin/python'} 12:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:37:39 INFO - Running setup.py (path:/tmp/pip-2qeqAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:37:39 INFO - Running setup.py (path:/tmp/pip-_jrZqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:37:39 INFO - Running setup.py (path:/tmp/pip-4nm5Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:37:39 INFO - Running setup.py (path:/tmp/pip-VDs0Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:37:39 INFO - Running setup.py (path:/tmp/pip-QMAihN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:37:39 INFO - Running setup.py (path:/tmp/pip-BosK1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:37:39 INFO - Running setup.py (path:/tmp/pip-epuSvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:37:39 INFO - Running setup.py (path:/tmp/pip-PWwbmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:37:40 INFO - Running setup.py (path:/tmp/pip-gKTR4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:37:40 INFO - Running setup.py (path:/tmp/pip-BUcYU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:37:40 INFO - Running setup.py (path:/tmp/pip-VCUZ98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:37:40 INFO - Running setup.py (path:/tmp/pip-hLv9xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:37:40 INFO - Running setup.py (path:/tmp/pip-Wlayjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:37:40 INFO - Running setup.py (path:/tmp/pip-5pa1ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:40 INFO - Running setup.py (path:/tmp/pip-TZRvuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:37:40 INFO - Running setup.py (path:/tmp/pip-E4m4kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:37:40 INFO - Running setup.py (path:/tmp/pip-2rmN6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:37:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:37:40 INFO - Running setup.py install for manifestparser 12:37:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:37:40 INFO - Running setup.py install for mozcrash 12:37:40 INFO - Running setup.py install for mozdebug 12:37:40 INFO - Running setup.py install for mozdevice 12:37:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Running setup.py install for mozfile 12:37:41 INFO - Running setup.py install for mozhttpd 12:37:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Running setup.py install for mozinfo 12:37:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Running setup.py install for mozInstall 12:37:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Running setup.py install for mozleak 12:37:41 INFO - Running setup.py install for mozlog 12:37:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Running setup.py install for moznetwork 12:37:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:37:41 INFO - Running setup.py install for mozprocess 12:37:41 INFO - Running setup.py install for mozprofile 12:37:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:37:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:37:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:37:42 INFO - Running setup.py install for mozrunner 12:37:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:37:42 INFO - Running setup.py install for mozscreenshot 12:37:42 INFO - Running setup.py install for moztest 12:37:42 INFO - Running setup.py install for mozversion 12:37:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:37:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:37:42 INFO - Cleaning up... 12:37:42 INFO - Return code: 0 12:37:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:42 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 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:42 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 12:37:42 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 12:37:42 INFO - Using env: {'DISPLAY': ':0', 12:37:42 INFO - 'HOME': '/home/cltbld', 12:37:42 INFO - 'LANG': 'en_US.UTF-8', 12:37:42 INFO - 'LANGUAGE': 'en_US:en', 12:37:42 INFO - 'LOGNAME': 'cltbld', 12:37:42 INFO - 'MAIL': '/var/mail/cltbld', 12:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:42 INFO - 'MOZ_NO_REMOTE': '1', 12:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:42 INFO - 'NO_EM_RESTART': '1', 12:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:42 INFO - 'PWD': '/builds/slave/test', 12:37:42 INFO - 'SHELL': '/bin/bash', 12:37:42 INFO - 'SHLVL': '1', 12:37:42 INFO - 'TERM': 'linux', 12:37:42 INFO - 'TMOUT': '86400', 12:37:42 INFO - 'USER': 'cltbld', 12:37:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:42 INFO - '_': '/tools/buildbot/bin/python'} 12:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:37:42 INFO - Running setup.py (path:/tmp/pip-bYOfvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:37:42 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)) 12:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:37:42 INFO - Running setup.py (path:/tmp/pip-6wmxpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:37:42 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)) 12:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:37:42 INFO - Running setup.py (path:/tmp/pip-du8iCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:37:42 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)) 12:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:37:42 INFO - Running setup.py (path:/tmp/pip-mOXniC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:37:42 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)) 12:37:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:37:42 INFO - Running setup.py (path:/tmp/pip-ebFrF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:37:43 INFO - Running setup.py (path:/tmp/pip-0Qp7Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:37:43 INFO - Running setup.py (path:/tmp/pip-VDcv7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:37:43 INFO - Running setup.py (path:/tmp/pip-DTeRou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:37:43 INFO - Running setup.py (path:/tmp/pip-RGyC1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:37:43 INFO - Running setup.py (path:/tmp/pip-7wdi5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:37:43 INFO - Running setup.py (path:/tmp/pip-nAjY87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:37:43 INFO - Running setup.py (path:/tmp/pip-gocOrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:37:43 INFO - Running setup.py (path:/tmp/pip-rxKZJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:37:43 INFO - Running setup.py (path:/tmp/pip-uTypZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:43 INFO - Running setup.py (path:/tmp/pip-Z8BNCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:37:43 INFO - Running setup.py (path:/tmp/pip-OrA56C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:37:43 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)) 12:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:37:43 INFO - Running setup.py (path:/tmp/pip-U657a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:37:43 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)) 12:37:43 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)) 12:37:43 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)) 12:37:43 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)) 12:37:43 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)) 12:37:43 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)) 12:37:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:37:43 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 12:37:43 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 12:37:43 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 12:37:43 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 12:37:43 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 12:37:43 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 12:37:45 INFO - Downloading blessings-1.6.tar.gz 12:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:37:45 INFO - Installing collected packages: blessings 12:37:45 INFO - Running setup.py install for blessings 12:37:45 INFO - Successfully installed blessings 12:37:45 INFO - Cleaning up... 12:37:46 INFO - Return code: 0 12:37:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:37:46 INFO - Reading from file tmpfile_stdout 12:37:46 INFO - Current package versions: 12:37:46 INFO - argparse == 1.2.1 12:37:46 INFO - blessings == 1.6 12:37:46 INFO - blobuploader == 1.2.4 12:37:46 INFO - docopt == 0.6.1 12:37:46 INFO - manifestparser == 1.1 12:37:46 INFO - mozInstall == 1.12 12:37:46 INFO - mozcrash == 0.17 12:37:46 INFO - mozdebug == 0.1 12:37:46 INFO - mozdevice == 0.48 12:37:46 INFO - mozfile == 1.2 12:37:46 INFO - mozhttpd == 0.7 12:37:46 INFO - mozinfo == 0.9 12:37:46 INFO - mozleak == 0.1 12:37:46 INFO - mozlog == 3.1 12:37:46 INFO - moznetwork == 0.27 12:37:46 INFO - mozprocess == 0.22 12:37:46 INFO - mozprofile == 0.28 12:37:46 INFO - mozrunner == 6.11 12:37:46 INFO - mozscreenshot == 0.1 12:37:46 INFO - mozsystemmonitor == 0.0 12:37:46 INFO - moztest == 0.7 12:37:46 INFO - mozversion == 1.4 12:37:46 INFO - psutil == 3.1.1 12:37:46 INFO - requests == 1.2.3 12:37:46 INFO - wsgiref == 0.1.2 12:37:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:37:46 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')]} 12:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:46 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')]} 12:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:46 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 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:46 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 12:37:46 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 12:37:46 INFO - Using env: {'DISPLAY': ':0', 12:37:46 INFO - 'HOME': '/home/cltbld', 12:37:46 INFO - 'LANG': 'en_US.UTF-8', 12:37:46 INFO - 'LANGUAGE': 'en_US:en', 12:37:46 INFO - 'LOGNAME': 'cltbld', 12:37:46 INFO - 'MAIL': '/var/mail/cltbld', 12:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:46 INFO - 'MOZ_NO_REMOTE': '1', 12:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:46 INFO - 'NO_EM_RESTART': '1', 12:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:46 INFO - 'PWD': '/builds/slave/test', 12:37:46 INFO - 'SHELL': '/bin/bash', 12:37:46 INFO - 'SHLVL': '1', 12:37:46 INFO - 'TERM': 'linux', 12:37:46 INFO - 'TMOUT': '86400', 12:37:46 INFO - 'USER': 'cltbld', 12:37:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:46 INFO - '_': '/tools/buildbot/bin/python'} 12:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 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)) 12:37:46 INFO - Cleaning up... 12:37:46 INFO - Return code: 0 12:37:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:37:46 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')]} 12:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:46 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')]} 12:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:46 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 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:46 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 12:37:46 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 12:37:46 INFO - Using env: {'DISPLAY': ':0', 12:37:46 INFO - 'HOME': '/home/cltbld', 12:37:46 INFO - 'LANG': 'en_US.UTF-8', 12:37:46 INFO - 'LANGUAGE': 'en_US:en', 12:37:46 INFO - 'LOGNAME': 'cltbld', 12:37:46 INFO - 'MAIL': '/var/mail/cltbld', 12:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:46 INFO - 'MOZ_NO_REMOTE': '1', 12:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:46 INFO - 'NO_EM_RESTART': '1', 12:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:46 INFO - 'PWD': '/builds/slave/test', 12:37:46 INFO - 'SHELL': '/bin/bash', 12:37:46 INFO - 'SHLVL': '1', 12:37:46 INFO - 'TERM': 'linux', 12:37:46 INFO - 'TMOUT': '86400', 12:37:46 INFO - 'USER': 'cltbld', 12:37:46 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:46 INFO - '_': '/tools/buildbot/bin/python'} 12:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:46 INFO - Downloading/unpacking jsonschema 12:37:46 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 12:37:46 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 12:37:46 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 12:37:46 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 12:37:46 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 12:37:46 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 12:37:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:37:48 INFO - Downloading/unpacking functools32 (from jsonschema) 12:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:48 INFO - Downloading functools32-3.2.3-2.tar.gz 12:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:37:48 INFO - warning: no files found matching '*.txt' 12:37:48 INFO - no previously-included directories found matching 'build' 12:37:48 INFO - no previously-included directories found matching 'dist' 12:37:48 INFO - no previously-included directories found matching '.git*' 12:37:48 INFO - Installing collected packages: jsonschema, functools32 12:37:48 INFO - Running setup.py install for functools32 12:37:49 INFO - warning: no files found matching '*.txt' 12:37:49 INFO - no previously-included directories found matching 'build' 12:37:49 INFO - no previously-included directories found matching 'dist' 12:37:49 INFO - no previously-included directories found matching '.git*' 12:37:49 INFO - Successfully installed jsonschema functools32 12:37:49 INFO - Cleaning up... 12:37:49 INFO - Return code: 0 12:37:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:37:49 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')]} 12:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:49 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')]} 12:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10c1f3ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ac5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', '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 12:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:37:49 INFO - Using env: {'DISPLAY': ':0', 12:37:49 INFO - 'HOME': '/home/cltbld', 12:37:49 INFO - 'LANG': 'en_US.UTF-8', 12:37:49 INFO - 'LANGUAGE': 'en_US:en', 12:37:49 INFO - 'LOGNAME': 'cltbld', 12:37:49 INFO - 'MAIL': '/var/mail/cltbld', 12:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:49 INFO - 'MOZ_NO_REMOTE': '1', 12:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:49 INFO - 'NO_EM_RESTART': '1', 12:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:37:49 INFO - 'PWD': '/builds/slave/test', 12:37:49 INFO - 'SHELL': '/bin/bash', 12:37:49 INFO - 'SHLVL': '1', 12:37:49 INFO - 'TERM': 'linux', 12:37:49 INFO - 'TMOUT': '86400', 12:37:49 INFO - 'USER': 'cltbld', 12:37:49 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:49 INFO - '_': '/tools/buildbot/bin/python'} 12:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:37:49 INFO - Downloading/unpacking flake8 12:37:49 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 12:37:49 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 12:37:49 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 12:37:49 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 12:37:49 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 12:37:49 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 12:37:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:37:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:37:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:37:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:37:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:37:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:37:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:37:52 INFO - no previously-included directories found matching 'docs/_build' 12:37:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:37:52 INFO - Running setup.py install for pep8 12:37:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:37:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:37:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:37:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:37:52 INFO - no previously-included directories found matching 'docs/_build' 12:37:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:37:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:37:52 INFO - Cleaning up... 12:37:52 INFO - Return code: 0 12:37:52 INFO - Running post-action listener: _resource_record_post_action 12:37:52 INFO - Running post-action listener: _start_resource_monitoring 12:37:52 INFO - Starting resource monitoring. 12:37:52 INFO - ##### 12:37:52 INFO - ##### Running install step. 12:37:52 INFO - ##### 12:37:52 INFO - Running pre-action listener: _resource_record_pre_action 12:37:52 INFO - Running main action method: install 12:37:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:37:52 INFO - Reading from file tmpfile_stdout 12:37:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:37:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:37:52 INFO - Reading from file tmpfile_stdout 12:37:52 INFO - Output received: 12:37:52 INFO - Usage: mozinstall [options] installer 12:37:52 INFO - Options: 12:37:52 INFO - -h, --help show this help message and exit 12:37:52 INFO - -d DEST, --destination=DEST 12:37:52 INFO - Directory to install application into. [default: 12:37:52 INFO - "/builds/slave/test"] 12:37:52 INFO - --app=APP Application being installed. [default: firefox] 12:37:52 INFO - mkdir: /builds/slave/test/build/application 12:37:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:38:08 INFO - Reading from file tmpfile_stdout 12:38:08 INFO - Output received: 12:38:08 INFO - /builds/slave/test/build/application/firefox/firefox 12:38:08 INFO - Running post-action listener: _resource_record_post_action 12:38:08 INFO - ##### 12:38:08 INFO - ##### Running run-tests step. 12:38:08 INFO - ##### 12:38:08 INFO - Running pre-action listener: _resource_record_pre_action 12:38:08 INFO - Running main action method: run_tests 12:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:38:08 INFO - Python 2.7.3 12:38:08 INFO - Return code: 0 12:38:08 INFO - grabbing minidump binary from tooltool 12:38: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')]} 12:38:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213b410>, '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 0x213c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:38:08 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 12:38:08 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 12:38:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:38:08 INFO - Return code: 0 12:38:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:38:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:38:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:38:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:38:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:38:09 INFO - Return code: 0 12:38:09 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/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 12:38:09 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/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 12:38:09 INFO - Using env: {'DISPLAY': ':0', 12:38:09 INFO - 'HOME': '/home/cltbld', 12:38:09 INFO - 'LANG': 'en_US.UTF-8', 12:38:09 INFO - 'LANGUAGE': 'en_US:en', 12:38:09 INFO - 'LOGNAME': 'cltbld', 12:38:09 INFO - 'MAIL': '/var/mail/cltbld', 12:38:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:38:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:38:09 INFO - 'MOZ_NO_REMOTE': '1', 12:38:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:38:09 INFO - 'NO_EM_RESTART': '1', 12:38:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:38:09 INFO - 'PWD': '/builds/slave/test', 12:38:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:38:09 INFO - 'SHELL': '/bin/bash', 12:38:09 INFO - 'SHLVL': '1', 12:38:09 INFO - 'TERM': 'linux', 12:38:09 INFO - 'TMOUT': '86400', 12:38:09 INFO - 'USER': 'cltbld', 12:38:09 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687', 12:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:38:09 INFO - '_': '/tools/buildbot/bin/python'} 12:38:09 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/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 12:38:09 INFO - mozversion application_buildid: 20160402110310 12:38:09 INFO - mozversion application_changeset: 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 12:38:09 INFO - mozversion application_display_name: Nightly 12:38:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:38:09 INFO - mozversion application_name: Firefox 12:38:09 INFO - mozversion application_remotingname: firefox 12:38:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:38:09 INFO - mozversion application_vendor: Mozilla 12:38:09 INFO - mozversion application_version: 48.0a1 12:38:09 INFO - mozversion platform_buildid: 20160402110310 12:38:09 INFO - mozversion platform_changeset: 1f8433e85420fc2156ac0dbd68186cef5cf1ebe8 12:38:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:38:09 INFO - mozversion platform_version: 48.0a1 12:38:09 INFO - using testdate: 1459625889 12:38:09 INFO - actual date: 1459625889 12:38:09 INFO - starting webserver on 'localhost:38225' 12:38:09 INFO - SUITE-START | Running 2 tests 12:38:09 INFO - TEST-START | dromaeo_css 12:38:09 INFO - operating with platform_type : linux_ 12:38:09 INFO - Initialising browser for dromaeo_css test... 12:38:09 INFO - TEST-INFO | started process 22550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKv3dzo/profile http://localhost:38225/getInfo.html) 12:38:14 INFO - PROCESS | 22550 | __metrics Screen width/height:1600/1200 12:38:14 INFO - PROCESS | 22550 | colorDepth:24 12:38:14 INFO - PROCESS | 22550 | Browser inner width/height: 1024/697 12:38:14 INFO - PROCESS | 22550 | __metrics 12:38:15 ERROR - PROCESS | 22550 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:38:15 INFO - TEST-INFO | 22550: exit 0 12:38:15 INFO - Browser initialized. 12:38:15 INFO - Running cycle 1/1 for dromaeo_css test... 12:38:16 INFO - TEST-INFO | started process 22630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKv3dzo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:27 INFO - PROCESS | 22630 | RSS: Main: 154968064 12:38:27 INFO - PROCESS | 22630 | 12:39:18 INFO - PROCESS | 22630 | 1459625958957 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] 12:41:30 INFO - PROCESS | 22630 | Cycle 1(1): loaded http://localhost:38225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38225/tests/dromaeo/cssquery-ext.html) 12:41:31 INFO - PROCESS | 22630 | RSS: Main: 231743488 12:41:31 INFO - PROCESS | 22630 | 12:44:33 INFO - PROCESS | 22630 | Cycle 1(1): loaded http://localhost:38225/tests/dromaeo/cssquery-ext.html (next: http://localhost:38225/tests/dromaeo/cssquery-jquery.html) 12:44:34 INFO - PROCESS | 22630 | RSS: Main: 233824256 12:44:34 INFO - PROCESS | 22630 | 12:47:36 INFO - PROCESS | 22630 | Cycle 1(1): loaded http://localhost:38225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38225/tests/dromaeo/cssquery-mootools.html) 12:47:36 INFO - PROCESS | 22630 | RSS: Main: 236425216 12:47:36 INFO - PROCESS | 22630 | 12:50:38 INFO - PROCESS | 22630 | Cycle 1(1): loaded http://localhost:38225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38225/tests/dromaeo/cssquery-prototype.html) 12:50:39 INFO - PROCESS | 22630 | RSS: Main: 221720576 12:50:39 INFO - PROCESS | 22630 | 12:53:42 INFO - PROCESS | 22630 | Cycle 1(1): loaded http://localhost:38225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38225/tests/dromaeo/cssquery-yui.html) 12:53:42 INFO - PROCESS | 22630 | RSS: Main: 201007104 12:53:42 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | Cycle 1(1): loaded http://localhost:38225/tests/dromaeo/cssquery-yui.html (next: http://localhost:38225/tests/dromaeo/cssquery-dojo.html) 12:56:45 INFO - PROCESS | 22630 | RSS: Main: 270397440 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | __start_tp_report 12:56:45 INFO - PROCESS | 22630 | _x_x_mozilla_page_load 12:56:45 INFO - PROCESS | 22630 | _x_x_mozilla_page_load_details 12:56:45 INFO - PROCESS | 22630 | |i|pagename|runs| 12:56:45 INFO - PROCESS | 22630 | |0;dojo.html;2580.8580528070956;2678.0745687256544;2685.785137189025;2694.12440956689;2720.993232503973;4588.2658774596075;4601.930971035437;4623.884402889929;4659.464161621415;4666.626669866411;4618.491965883759;4640.350350950869;4661.627069834413;4697.084068606615;4705.505921878204;4236.216299984498;4243.618074373306;4281.229378711831;4310.741355518679;4375.453068366454;4324.243257429937;4349.151915376503;4350.477942646871;4379.540148284432;4396.120775844828;4183.6234738873345;4194.958050419487;4270.829166833339;4277.743335399886;4287.421198138242;4295.8496452624;4303.526612072669;4304.182205380967;4347.608715215614;4354.9564504355185;4257.638100761408;4269.338252570857;4277.358396240557;4285.442892423996;4319.719218250803;4422.6682998774895;4454.955450445519;4526.6831321807485;4539.160255352737;4580.244259697146;5002.349694539723;5002.59979201663;5004.499550045003;5005.974970125162;5011;5020.799168033274;5022.296878437021;5031.723255220962;5038.949610503884;5081.034603425337;4595.793189306522;4627.051454451829;4692;4699.060187962421;4710.528947105262;5080.212567052113;5100.846974590768;5109.4379618241965;5123.103456895028;5150.536451719363;4921.7785199666105;4935.840077581765;4941.135301322254;4942.57988071018;4990.8752281193265;4885.2427873679635;4958.082754690394;5006.098902197639;5020.673656212334;5055.292259083732;4968.4286307075145;4969.080720066727;4978.27814966835;4979.078870408914;4990.351254336913;4922;4938.25926111079;4942.851714448572;4948.8762780930765;4968.254761785761;4091.7544947302663;4170.666346692257;4174.144300418407;4179.164167166578;4247.108107297502;3698.130939229279;3706.4069748840056;3724.2365315110337;3730.981345093257;3738.5887552369218;4272.33778764292;4306.20335237982;4310.482742070972;4310.827566897352;4314.935275970863;4979.950200498021;4982.352294201731;4985.725785081855;4993.27597498368;5019.899602007939;4304.139172165579;4306.397104405386;4309.91380172401;4335.82656693735;4352.347147927836;4361.193179261847;4418.138462999748;4450.443694538183;4459.576340247736;4510.985028368591;4675.6259499239295;4702.506236845082;4703.905921881543;4705.929411058837;4750.643701722384;4895.681780684244;4897.412310522617;4940.802367905244;4946.3817022872145;4987.750612469289;4651.558101980307;4676.532346765296;4686.062787442457;4690.765461726832;4712.552307530779;4872.512748725099;4911.287863259879;4929.334539837219;4936.8765780855765;4949.777260023236;4936.580390666833;4939.259111133359;4941.827036053721;4943.629227808001;4977.751112444291;4682.461516925598;4741.9051618968115;4819.204831202812;4829.106615276185;4832.903341933212;4816.373871396696;4832.540908613676;4836.879078023077;4849.660523763303;4887.242477416006;4715.0805592909055;4761.40482439695;4776.259679749644;4779.354787103696;4815.566599006106;4704.153252414599;4807.711537307773;4847.5394837490385;4889.168841297059;4902.2156454967035;4726.220173671306;4733.479317275166;4749.216379297377;4755.120302743865;4793.520647935318 12:56:45 INFO - PROCESS | 22630 | |1;ext.html;529.9046171689097;532.5845840244608;537.508180015286;541.8536995011347;550.6530885542107;26033.869830650845;33630.15924601886;34372.65627343729;34492.827535862285;34535.96392108241;35992;36466.817665911636;36468;36476.27047459056;36488.81755591225;7457.925420745804;7625.809354766147;7627.923720762777;7631.694732210705;7634.5037572557885;6498.382653647919;7801.609919504031;7802.21977802218;7802.414818888606;7802.960985195066;7755.650995705207;7815.882761758578;7821.061472623264;7827.178146294643;7828.256315650005;7732.536047837119;7797.76606701797;7810.453268271223;7819.530828150329;7822.1786712395515;7739.6904123834975;7860.410469214832;7861.646225919847;7864.724734634317;7864.960675196645;37902.43146352807;38227.23545529102;38301.80849095764;38343.80828095869;38456.80771596152;3021.350409661933;3115.766317526172;3255.7720959532844;3494.4583589543663;3850.8459661613783;28733.712662873313;28744.281392965135;28927;29161.854190729122;29576.704232957825;3369.6124945631323;3410.3179364127272;3465.2549701813978;3491.336646037245;3517.718582513393;242421;243658;243900;244988;245104;47520.5247947523;48335.516644833806;54196;54474.45525544694;54608.72695636576;47808.28287575689;48417.273740893914;48428.27357589639;48524.51475485271;48544.514554854;14029.859701402855;14030.228337441335;14103.294835258195;14151.221682807338;14169.079009864327;8857.512836793909;10610.628627997983;10612.57549698019;11153.330800152016;11361.94319028416;17583.912080439517;17819.10904454772;17940.730889036677;17945;17994.460166195036;6760.1549806274215;6763.323667633197;6909.343612356919;6929.41100006495;7049.859002819915;922.1331947968888;931.8462453695064;934.4066517761134;978.814025335184;1055.2929537210089;26161;26373;26676.73323266781;27323.726762732516;27332.316692082855;981.5582987655583;984.5323471351194;1023.7287118913493;1024.206240163864;1033.0289527843802;13834.30828458573;14080.295985200699;14094.154350738989;14544.709105817825;14560.85439145595;273174;274870;277013;277735;278175;47734.28398574024;48055.5194448058;48089.5191048092;48147.518524815;48165.518344816104;1050.1336397472116;1105.1987309200927;1203.6148432501516;1227;1234.0682784497826;25825.870870645525;25897.482050359264;26284.474310514066;26393.472130557664;26654.333641659112;32494.187645309055;32626.184345391554;32757.836210818794;32812;32836.34327313488;172057;172087;172329;173083.13458432627;173123;26412;29804.552931706476;31074.378512430078;31186.844065779525;31794;34765.65234347624;34824.303513930085;35571.466428003085;35849;35930.101747455476;30150.396992060476;30213.697863021087;30541.847290763402;30880.69119308868;30989.845050774602;29224.707752922197;29708.257293567833;30139.69860301369;30307.545386818776;30700.692993070676;32770.67229327676;33255.667443325256;33305.500417494244;33668.65325386957;33675.326493470486;29300.413991720474;29400.7059929398;29430.705692942796;29558;29676.25809354697;23448;23950.401239969142;24099.397515062265;24177.879110604335;24684.876575617007 12:56:45 INFO - PROCESS | 22630 | |2;jquery.html;350.8508883724417;352.41589057187946;356.6522640425585;365.16377495535227;365.2712837888411;15560.53318400447;15613.86944814943;17081.829181708163;17320;17335.306587736508;16209.432669856527;16544.255508502116;16842.0736859473;16849.241784119746;16860.241289141988;4813.205821039524;4947.7031378117335;4984.077945580079;5031.874203144932;5036.294918711384;4914.1400254955415;4977.701337919736;4979.551840334369;4996.5503104720565;5030.06943715412;4896.1186986342445;4932.506749325074;4933.407991041062;4937.210046392578;5002.424721157059;5148.5881129509735;5150.639455238135;5183.118869792144;5187.8443646690475;5189.195674670414;4987.177115775893;5002.499750025005;5002.699838009731;5005.924911126336;5008.048470790538;11102.222844400896;11660.941695291554;11662.416879156093;11667.474963626657;11672.35802030888;1820.8907465551977;1879.830815226636;1881.3133206379573;1882.9905850470798;1949.0157470477318;8454.450460720034;8809.471431714117;10972.835407468894;12491.812622810665;12961.351932403342;1713.3146741303578;1720.81931397204;1727.136431784108;1764.0650455258733;1792.4801807475817;53970.730146349015;55492;57872.13191802127;59143.40856591422;60116.69941650264;9415.764605884908;9436.71689849292;9550.570224339921;9612.615495380247;9789;12826.23042617446;12872.22766634005;12882.355882205853;12930.418131184118;12931.806022909665;7010.824729381806;7098.574085554883;7109.857802844018;7242.601656908815;7267.63661816907;6939;6966.442684585221;6971.965140174369;6980.092587963532;7039.401650859734;4105.281575724236;4166.541680415152;4205.36919462077;4244.575542445731;4258.318669012943;1632.7061128996895;1642.901425914425;1706.590418299624;1754.8069712331633;1758.3581992572874;763.5342441110918;772.1737740617598;805.5126648377765;806.6249194124761;832.0431503770712;14487.49293774734;14894.329755161043;14894.776578351333;14968.850311496746;15043.849561504245;794.9324307433933;800.5756948817136;828.0973738624928;830.5722552885269;845.1084106267946;8701.869471957925;8769.254613357936;8919.331050171264;8994.550272486349;9022.684206052756;381995;394262;395449;395839;395844;65890;66298.66850665715;67086.30395872242;67185.66407167933;67819.66090169517;952.7760976170595;965.2567523007385;965.3676841668719;975.302658599105;1012.7063151685928;14021.8782497402;14119.505817296345;14364.784528231876;14455.060421072596;14591.197484138474;29455.705442946153;31052.534211986385;33316.66683333136;33664.3267134651;35252.47121293234;45024.54975450203;47989;48009.5199048019;48081.52344196776;48146.759266203444;7134.714611415693;7147.356737893615;7202.96398518004;7262.346388825031;7274.127104747464;6921.792346229621;8792.98880628736;9129.589168487566;11430.11349155169;11677.357745324089;9759.512024398893;9973.650922217977;10060.547275372772;10451.714866483515;10660.62687805923;9861.457619830979;9991.25065620067;10043.899561004297;10102.242331824995;10401.479926003822;9866.358686685342;9942.701718948443;10265.538050787583;10505.212109091695;10623.415712135908;7224;7239.565626062453;7254.746083887038;7418.8145296365865;7476.364509016795;8603.69887053975;9760.755981100529;9946.701598952042;10057.396556206651;10079.24405669563 12:56:45 INFO - PROCESS | 22630 | |3;mootools.html;1279.027938766537;1338.511443323187;1352.513095285697;1492.3135357735441;1725.3184991928188;6538.248101468333;6991.056207411998;7207.675654595542;7211.7475888343915;7217.530860494065;7073.469489788261;7219.133703955519;7229.313215244557;7230.9276907230915;7238.638068096588;1884.3498992847447;1936.845052395812;2128.946776330589;2191.660292654641;2232.0402227042364;2201.2955854126685;2209.591225623257;2210.3368989303226;2211.215018668374;2212.5685491329195;2073.8859362735043;2099.254764558583;2113.2392338758114;2148.226638410179;2149.5485947950947;2142.9464263393384;2174.3694328644674;2186.1364760919428;2189.6496560550236;2191.671249312608;2190.8028277454946;2204.239537359608;2209.3371988403414;2210.2264207527237;2211.900464479102;7405.222451642554;7443.330100290946;7443.851122977564;7446.441516886201;7458.179600243969;4486.641068714495;4575.359449677047;4576.931346029813;4599.609033232179;4604.654650901196;2788.776897848167;2966.2732630505448;2967.866446009935;2990.177701132206;3002.654694710093;880.2913654508119;928.4661319741176;931.8229536388064;950.1686024728363;957.090763774417;10171.033751793568;10175.084242418145;10187.949060254725;10195;10195.541200645914;4029.81865816039;4042.8787136385954;4110.0752330725345;4135.421041054195;4135.545090040093;8752.124787521198;8760.386772925962;8764.342674299452;8771;8778.736637900873;4617.2612382018715;4634.21218392874;4634.768261586907;4649.511801260886;4655.092257009851;3638.872639457606;3775.8300876460075;4001.039750459927;4175.081482073939;4207.1375368050085;3483.8083905385447;3512.4906888501023;3522.313148935984;3561.2521370511963;3591.425371940477;1137.181229514748;1138.9373584452935;1142.5829572206085;1158.3397463445924;1158.6408213453856;972.397113789455;993.3195760903805;1170.4674373160192;1191.2614179208947;1197.694587880085;6817.113775209191;6845.623490707959;6852.486063545254;6867.175938887365;6878.69045892936;1107.8670559532748;1117.9776404471866;1152.5965911930757;1155.5204590095184;1166.3701601135463;5337.759800808973;5494.532964698045;5498.780048798083;5504.119340905436;5512.586556008316;8696.17386348296;8928.241099506486;9110.954445227864;9111;9358.766030849283;9047.864282035775;9142.131497507859;9189.954050229706;9232.584533696;9242.983271840092;6948.583085014915;6997.265287144878;7106.289371062852;7121.501494895308;7172.892406613801;6722.932770672426;6753.15585551806;6815.318468153145;6817.863642727217;6832.180138383425;7934.484258523177;8079.555624440713;8080.83838323242;8173.959130204311;8316.708915187939;8139.267465928095;8289.626966786629;8374.330053595819;8388.119247478928;8523.659053637784;5437.26596909428;5795.797147099831;6016.819495415145;6129.141920131096;6204.007358822567;6883.070785443901;6902.516823822485;6948.861022779617;6952.721891124298;6961.79114626562;6118.510519158368;6248.4376406123665;6262.405071518198;6304.936950630435;6344.460720838596;5979;6073.908891366545;6077.453029227391;6144.631322120687;6192.504599632109;6710.261871194067;6762.222344430454;6787.423069039187;6798.796036118924;6809.319068093349;6047.03247480401;6121.173641558333;6125.326214116354;6157.815265542041;6167.414095660905;6271.3415091414745;6431.839204019937;6434.903476447764;6435.292117867125;6438.259600145856 12:56:45 INFO - PROCESS | 22630 | |4;prototype.html;318.3339531424321;318.4617995587457;323.1871842316574;324.09092495550004;325.50035695207845;5225.8954820903555;5260.500252476014;5351.919721204185;5354.544863686581;5363.570914326854;5212.921806172911;5269.235960785693;5269.394019687737;5271.736413179345;5294.179402192657;3966.0679740261016;4031.6169963853386;4120.052387950758;4150.3359462486005;4164.583541645841;4130.586941305875;4147.108371700099;4148.502179738421;4152.086540960984;4159.83360665573;4091.8158682859344;4092.9386059209137;4101.871985204063;4106.938395924063;4107.199096176247;3907.8241479133367;3974.225026119908;3995.20095980805;4076.7961601919787;4105.363668631367;3604.693601043888;3609.8917032489067;3616.385214513539;3617.8914632561064;3618.4029635110173;4996.875078123039;4999.975000125012;5007.399112106534;5007.4491805901325;5021.748912554394;4711.623070154379;4713.104510143062;4715.316279139505;4716.151092803294;4729.881752956169;5485.0949593317455;5495.780168793243;5497.47773961473;5501;5506.394296627408;3965.643092121723;3974.741641793274;3978.681705463585;3979.5622481527007;3980.2835489611857;5579.461345088016;5760.107183386582;5810.477057064884;5832.416758324176;5837.445442682938;3956.1889812588925;3964.1080756829483;3981.5222173338807;3985.103351745834;3988.641022308006;4007.278689835799;4023.5574086850424;4040.070783719761;4046.109855831712;4046.433499310099;4634.397528321364;4637.39713837199;4645.396098507173;4645.535446455395;4650.395448591729;5563;5564.638298510665;5569.359523654751;5574.58190635704;5582.441755824385;1398.6713122416224;1413.9010269281257;1421.3106643278002;1424.6367176370165;1425.5438259756986;937.920276776468;951.1107114847501;959.6737109382843;970.1171933540444;974.2498276327188;4768.117898188846;4821.975890120597;4905.975470122627;4918.729469879119;4924.704517728947;5751.424857514299;5773.769049238067;5778.508826749773;5780.306363236438;5830.650160990354;4892.2661600760175;4942.357493525818;4943.901121977612;4952.182889823211;4953.281774142729;3078.984605077005;3092.7835051546626;3101.5037593984853;3120.095172400024;3122.5160100184507;5434.483724046209;5471.042567550663;5472.835814925558;5472.91790623141;5493.835184944458;5782.624129431573;5897.144913987534;5973.820785376446;5981.3719559445635;5981.970090149522;5474.425185355481;5490.094134467848;5493.752781124859;5495.670259784346;5508.366537848199;5759.769609215585;5764.452377024176;5779.162021506774;5783.6818974955095;5790.160426738184;5642.069058605284;5688.203651488712;5694.658320500783;5700.144978253129;5706.372299047019;5453.536449401845;5480.369757477941;5483.259759932358;5485.6982865942755;5492.725363731717;3857.440671102618;3935.2916475034767;3984.900377490586;3990.74060186087;3991.92016159681;5656.321241451053;5696.287964004499;5698.857528561653;5738.799142030176;5743.569232307677;5552.000639884859;5555.916661250004;5568.721563921868;5571.08077167279;5575.135853942646;5554.583406244467;5573.470520300565;5588.133839254922;5590.580706447114;5591.356993945748;5436.592255580927;5463.289772329572;5479.150731636602;5480.6437581557075;5481.314835645544;5445.50990410849;5585.134304182858;5598.916016259678;5603.075492543685;5613.719314034363;5426.593005524523;5466.91799622998;5470.288862447856;5473.616846820684;5485.9725701371235 12:56:45 INFO - PROCESS | 22630 | |5;yui.html;626.9279032911211;652.9738810447583;753.8153152477643;762.3139174742735;773.2808488106061;11393.316401015934;11502.597409090684;13618.591442256748;13905.860941390583;13922.582322530316;12920.870791292084;12923.80614290784;12939.805902911441;12957.805632915513;13042.60872173834;650.5868773328923;655.9540832141752;804.0753133896037;808.5593351623379;823.5305875650881;800.2517646000979;807.8222790985974;809.7327881798992;813.1461964936822;813.5403497024192;841.5960339037235;847.1909326593088;847.6948298612494;847.9364047696416;848.1264297773273;624.8063100438856;834.1283358889945;836.2599099796663;839.0434904209206;843.9113893041203;615.5291202230297;616.315889362807;616.7779599344233;617.0127795527121;617.237711426388;12098;12122.454489547992;12213.389330533439;12221;12235.571754988532;11051.778964420666;11374.71563210918;11397.772044559146;12058.457369418396;12258.938705306417;9619.51902404877;9812.215022798158;9845.753856153653;9866.753331166707;9929.702108936743;3302.53764472974;3363.3105213431186;3382.8815991440183;3383.915402114942;3403.149212696826;43958;44106.77946610247;44229.115417691784;44505.777471112764;44520;8844.646214151491;9074.183323500916;9133.543322833832;9851.310408271353;9935.254855885838;16431.835681643268;16440.342386304415;16446.095464749553;16649.50051498457;16659.16704164787;6358.109864618957;6485.156929599217;6882.759103431456;7008.369246767816;7251.963740181265;3716.7212459065677;3729.310077635646;3741.345264578688;3746.68153206975;3757.4176002719623;2733.3303340681264;2734.111413790526;2734.8495832728995;2752.518309295865;2763.585462180689;521.5254118751993;537.0279793573644;543.4348277791132;544.1076634319719;547.1300631995147;508.6083715539014;605.8848818724429;606.236142460503;628.7139351595014;639.2297281775542;8103.635336409876;8473.152684731478;8534.27458666008;8585.441946273471;8593.570321484025;605.9697015149313;607.5807692692028;617.5079923035242;623.6632218601904;631.4948041566728;3863.188730366598;3865.3235683755793;3921.764694118362;3975.1254723960683;4097.713160078825;51649.225261621104;52126.478735212164;52814;52868.73565632147;53260.73369633127;45820.77089614597;46028.539714603095;46294;46639.06721865611;47030.76484617624;41518.58481415208;41527;42025.159496809894;42346.57653423488;42416;7979.521228726295;8047.436679432383;8104.635291411782;8142;8243.670253189804;32009.359812803148;32036.67963320337;32426;32985.67014329826;33537;37551.43672844855;37677.4348384769;40038.79980600078;40998.385024224066;41658.79170604127;9436.622535098519;9504.097110774464;9508.809823803347;9779.706608801747;9839.065288797552;10716.19628527848;10767.6231331903;11026.117910567296;11027.17296202772;11177.497012634614;10032.548535315782;10125.088742013255;10194.643187488402;10249.538770755484;10380.844287335545;8953.776155596162;8974.102589741235;9063.501507417155;9341.906580934103;9509.66716164931;9805.362651427635;9929.702108936743;10194.133498652698;10204.795904081728;10234.948825255826;7653.923460765321;7759.262870027338;7822;8016.7194148204535;8022.9598852005365;7593.924060759322;7621.733239336597;7701.922980770345;7719.8070048247;7883.802904927423 12:56:45 INFO - PROCESS | 22630 | __end_tp_report 12:56:45 INFO - PROCESS | 22630 | __start_cc_report 12:56:45 INFO - PROCESS | 22630 | _x_x_mozilla_cycle_collect,990 12:56:45 INFO - PROCESS | 22630 | __end_cc_report 12:56:45 INFO - PROCESS | 22630 | __startTimestamp1459627005395__endTimestamp 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | ------- Summary: start ------- 12:56:45 INFO - PROCESS | 22630 | Number of tests: 6 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | [#0] dojo.html Cycles:165 Average:4598.73 Median:4705.51 stddev:469.79 (10.0%) stddev-sans-first:443.76 12:56:45 INFO - PROCESS | 22630 | Values: 2580.9 2678.1 2685.8 2694.1 2721.0 4588.3 4601.9 4623.9 4659.5 4666.6 4618.5 4640.4 4661.6 4697.1 4705.5 4236.2 4243.6 4281.2 4310.7 4375.5 4324.2 4349.2 4350.5 4379.5 4396.1 4183.6 4195.0 4270.8 4277.7 4287.4 4295.8 4303.5 4304.2 4347.6 4355.0 4257.6 4269.3 4277.4 4285.4 4319.7 4422.7 4455.0 4526.7 4539.2 4580.2 5002.3 5002.6 5004.5 5006.0 5011.0 5020.8 5022.3 5031.7 5038.9 5081.0 4595.8 4627.1 4692.0 4699.1 4710.5 5080.2 5100.8 5109.4 5123.1 5150.5 4921.8 4935.8 4941.1 4942.6 4990.9 4885.2 4958.1 5006.1 5020.7 5055.3 4968.4 4969.1 4978.3 4979.1 4990.4 4922.0 4938.3 4942.9 4948.9 4968.3 4091.8 4170.7 4174.1 4179.2 4247.1 3698.1 3706.4 3724.2 3731.0 3738.6 4272.3 4306.2 4310.5 4310.8 4314.9 4980.0 4982.4 4985.7 4993.3 5019.9 4304.1 4306.4 4309.9 4335.8 4352.3 4361.2 4418.1 4450.4 4459.6 4511.0 4675.6 4702.5 4703.9 4705.9 4750.6 4895.7 4897.4 4940.8 4946.4 4987.8 4651.6 4676.5 4686.1 4690.8 4712.6 4872.5 4911.3 4929.3 4936.9 4949.8 4936.6 4939.3 4941.8 4943.6 4977.8 4682.5 4741.9 4819.2 4829.1 4832.9 4816.4 4832.5 4836.9 4849.7 4887.2 4715.1 4761.4 4776.3 4779.4 4815.6 4704.2 4807.7 4847.5 4889.2 4902.2 4726.2 4733.5 4749.2 4755.1 4793.5 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | [#1] ext.html Cycles:180 Average:38567.74 Median:32791.34 stddev:61254.72 (186.8%) stddev-sans-first:61359.97 12:56:45 INFO - PROCESS | 22630 | Values: 529.9 532.6 537.5 541.9 550.7 26033.9 33630.2 34372.7 34492.8 34536.0 35992.0 36466.8 36468.0 36476.3 36488.8 7457.9 7625.8 7627.9 7631.7 7634.5 6498.4 7801.6 7802.2 7802.4 7803.0 7755.7 7815.9 7821.1 7827.2 7828.3 7732.5 7797.8 7810.5 7819.5 7822.2 7739.7 7860.4 7861.6 7864.7 7865.0 37902.4 38227.2 38301.8 38343.8 38456.8 3021.4 3115.8 3255.8 3494.5 3850.8 28733.7 28744.3 28927.0 29161.9 29576.7 3369.6 3410.3 3465.3 3491.3 3517.7 242421.0 243658.0 243900.0 244988.0 245104.0 47520.5 48335.5 54196.0 54474.5 54608.7 47808.3 48417.3 48428.3 48524.5 48544.5 14029.9 14030.2 14103.3 14151.2 14169.1 8857.5 10610.6 10612.6 11153.3 11361.9 17583.9 17819.1 17940.7 17945.0 17994.5 6760.2 6763.3 6909.3 6929.4 7049.9 922.1 931.8 934.4 978.8 1055.3 26161.0 26373.0 26676.7 27323.7 27332.3 981.6 984.5 1023.7 1024.2 1033.0 13834.3 14080.3 14094.2 14544.7 14560.9 273174.0 274870.0 277013.0 277735.0 278175.0 47734.3 48055.5 48089.5 48147.5 48165.5 1050.1 1105.2 1203.6 1227.0 1234.1 25825.9 25897.5 26284.5 26393.5 26654.3 32494.2 32626.2 32757.8 32812.0 32836.3 172057.0 172087.0 172329.0 173083.1 173123.0 26412.0 29804.6 31074.4 31186.8 31794.0 34765.7 34824.3 35571.5 35849.0 35930.1 30150.4 30213.7 30541.8 30880.7 30989.8 29224.7 29708.3 30139.7 30307.5 30700.7 32770.7 33255.7 33305.5 33668.7 33675.3 29300.4 29400.7 29430.7 29558.0 29676.3 23448.0 23950.4 24099.4 24177.9 24684.9 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | [#2] jquery.html Cycles:180 Average:23023.47 Median:4932.96 stddev:64437.18 (1306.3%) stddev-sans-first:64595.45 12:56:45 INFO - PROCESS | 22630 | Values: 350.9 352.4 356.7 365.2 365.3 15560.5 15613.9 17081.8 17320.0 17335.3 16209.4 16544.3 16842.1 16849.2 16860.2 4813.2 4947.7 4984.1 5031.9 5036.3 4914.1 4977.7 4979.6 4996.6 5030.1 4896.1 4932.5 4933.4 4937.2 5002.4 5148.6 5150.6 5183.1 5187.8 5189.2 4987.2 5002.5 5002.7 5005.9 5008.0 11102.2 11660.9 11662.4 11667.5 11672.4 1820.9 1879.8 1881.3 1883.0 1949.0 8454.5 8809.5 10972.8 12491.8 12961.4 1713.3 1720.8 1727.1 1764.1 1792.5 53970.7 55492.0 57872.1 59143.4 60116.7 9415.8 9436.7 9550.6 9612.6 9789.0 12826.2 12872.2 12882.4 12930.4 12931.8 7010.8 7098.6 7109.9 7242.6 7267.6 6939.0 6966.4 6972.0 6980.1 7039.4 4105.3 4166.5 4205.4 4244.6 4258.3 1632.7 1642.9 1706.6 1754.8 1758.4 763.5 772.2 805.5 806.6 832.0 14487.5 14894.3 14894.8 14968.9 15043.8 794.9 800.6 828.1 830.6 845.1 8701.9 8769.3 8919.3 8994.6 9022.7 381995.0 394262.0 395449.0 395839.0 395844.0 65890.0 66298.7 67086.3 67185.7 67819.7 952.8 965.3 965.4 975.3 1012.7 14021.9 14119.5 14364.8 14455.1 14591.2 29455.7 31052.5 33316.7 33664.3 35252.5 45024.5 47989.0 48009.5 48081.5 48146.8 7134.7 7147.4 7203.0 7262.3 7274.1 6921.8 8793.0 9129.6 11430.1 11677.4 9759.5 9973.7 10060.5 10451.7 10660.6 9861.5 9991.3 10043.9 10102.2 10401.5 9866.4 9942.7 10265.5 10505.2 10623.4 7224.0 7239.6 7254.7 7418.8 7476.4 8603.7 9760.8 9946.7 10057.4 10079.2 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | [#3] mootools.html Cycles:180 Average:5173.47 Median:6119.84 stddev:2684.34 (43.9%) stddev-sans-first:2675.90 12:56:45 INFO - PROCESS | 22630 | Values: 1279.0 1338.5 1352.5 1492.3 1725.3 6538.2 6991.1 7207.7 7211.7 7217.5 7073.5 7219.1 7229.3 7230.9 7238.6 1884.3 1936.8 2128.9 2191.7 2232.0 2201.3 2209.6 2210.3 2211.2 2212.6 2073.9 2099.3 2113.2 2148.2 2149.5 2142.9 2174.4 2186.1 2189.6 2191.7 2190.8 2204.2 2209.3 2210.2 2211.9 7405.2 7443.3 7443.9 7446.4 7458.2 4486.6 4575.4 4576.9 4599.6 4604.7 2788.8 2966.3 2967.9 2990.2 3002.7 880.3 928.5 931.8 950.2 957.1 10171.0 10175.1 10187.9 10195.0 10195.5 4029.8 4042.9 4110.1 4135.4 4135.5 8752.1 8760.4 8764.3 8771.0 8778.7 4617.3 4634.2 4634.8 4649.5 4655.1 3638.9 3775.8 4001.0 4175.1 4207.1 3483.8 3512.5 3522.3 3561.3 3591.4 1137.2 1138.9 1142.6 1158.3 1158.6 972.4 993.3 1170.5 1191.3 1197.7 6817.1 6845.6 6852.5 6867.2 6878.7 1107.9 1118.0 1152.6 1155.5 1166.4 5337.8 5494.5 5498.8 5504.1 5512.6 8696.2 8928.2 9111.0 9111.0 9358.8 9047.9 9142.1 9190.0 9232.6 9243.0 6948.6 6997.3 7106.3 7121.5 7172.9 6722.9 6753.2 6815.3 6817.9 6832.2 7934.5 8079.6 8080.8 8174.0 8316.7 8139.3 8289.6 8374.3 8388.1 8523.7 5437.3 5795.8 6016.8 6129.1 6204.0 6883.1 6902.5 6948.9 6952.7 6961.8 6118.5 6248.4 6262.4 6304.9 6344.5 5979.0 6073.9 6077.5 6144.6 6192.5 6710.3 6762.2 6787.4 6798.8 6809.3 6047.0 6121.2 6125.3 6157.8 6167.4 6271.3 6431.8 6434.9 6435.3 6438.3 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | [#4] prototype.html Cycles:180 Average:4617.65 Median:5282.96 stddev:1353.01 (25.6%) stddev-sans-first:1317.76 12:56:45 INFO - PROCESS | 22630 | Values: 318.3 318.5 323.2 324.1 325.5 5225.9 5260.5 5351.9 5354.5 5363.6 5212.9 5269.2 5269.4 5271.7 5294.2 3966.1 4031.6 4120.1 4150.3 4164.6 4130.6 4147.1 4148.5 4152.1 4159.8 4091.8 4092.9 4101.9 4106.9 4107.2 3907.8 3974.2 3995.2 4076.8 4105.4 3604.7 3609.9 3616.4 3617.9 3618.4 4996.9 5000.0 5007.4 5007.4 5021.7 4711.6 4713.1 4715.3 4716.2 4729.9 5485.1 5495.8 5497.5 5501.0 5506.4 3965.6 3974.7 3978.7 3979.6 3980.3 5579.5 5760.1 5810.5 5832.4 5837.4 3956.2 3964.1 3981.5 3985.1 3988.6 4007.3 4023.6 4040.1 4046.1 4046.4 4634.4 4637.4 4645.4 4645.5 4650.4 5563.0 5564.6 5569.4 5574.6 5582.4 1398.7 1413.9 1421.3 1424.6 1425.5 937.9 951.1 959.7 970.1 974.2 4768.1 4822.0 4906.0 4918.7 4924.7 5751.4 5773.8 5778.5 5780.3 5830.7 4892.3 4942.4 4943.9 4952.2 4953.3 3079.0 3092.8 3101.5 3120.1 3122.5 5434.5 5471.0 5472.8 5472.9 5493.8 5782.6 5897.1 5973.8 5981.4 5982.0 5474.4 5490.1 5493.8 5495.7 5508.4 5759.8 5764.5 5779.2 5783.7 5790.2 5642.1 5688.2 5694.7 5700.1 5706.4 5453.5 5480.4 5483.3 5485.7 5492.7 3857.4 3935.3 3984.9 3990.7 3991.9 5656.3 5696.3 5698.9 5738.8 5743.6 5552.0 5555.9 5568.7 5571.1 5575.1 5554.6 5573.5 5588.1 5590.6 5591.4 5436.6 5463.3 5479.2 5480.6 5481.3 5445.5 5585.1 5598.9 5603.1 5613.7 5426.6 5466.9 5470.3 5473.6 5486.0 12:56:45 INFO - PROCESS | 22630 | 12:56:45 INFO - PROCESS | 22630 | [#5] yui.html Cycles:180 Average:12545.88 Median:540.23 stddev:14506.22 (2685.2%) stddev-sans-first:14519.30 12:56:45 INFO - PROCESS | 22630 | Values: 626.9 653.0 753.8 762.3 773.3 11393.3 11502.6 13618.6 13905.9 13922.6 12920.9 12923.8 12939.8 12957.8 13042.6 650.6 656.0 804.1 808.6 823.5 800.3 807.8 809.7 813.1 813.5 841.6 847.2 847.7 847.9 848.1 624.8 834.1 836.3 839.0 843.9 615.5 616.3 616.8 617.0 617.2 12098.0 12122.5 12213.4 12221.0 12235.6 11051.8 11374.7 11397.8 12058.5 12258.9 9619.5 9812.2 9845.8 9866.8 9929.7 3302.5 3363.3 3382.9 3383.9 3403.1 43958.0 44106.8 44229.1 44505.8 44520.0 8844.6 9074.2 9133.5 9851.3 9935.3 16431.8 16440.3 16446.1 16649.5 16659.2 6358.1 6485.2 6882.8 7008.4 7252.0 3716.7 3729.3 3741.3 3746.7 3757.4 2733.3 2734.1 2734.8 2752.5 2763.6 521.5 537.0 543.4 544.1 547.1 508.6 605.9 606.2 628.7 639.2 8103.6 8473.2 8534.3 8585.4 8593.6 606.0 607.6 617.5 623.7 631.5 3863.2 3865.3 3921.8 3975.1 4097.7 51649.2 52126.5 52814.0 52868.7 53260.7 45820.8 46028.5 46294.0 46639.1 47030.8 41518.6 41527.0 42025.2 42346.6 42416.0 7979.5 8047.4 8104.6 8142.0 8243.7 32009.4 32036.7 32426.0 32985.7 33537.0 37551.4 37677.4 40038.8 40998.4 41658.8 9436.6 9504.1 9508.8 9779.7 9839.1 10716.2 10767.6 11026.1 11027.2 11177.5 10032.5 10125.1 10194.6 10249.5 10380.8 8953.8 8974.1 9063.5 9341.9 9509.7 9805.4 9929.7 10194.1 10204.8 10234.9 7653.9 7759.3 7822.0 8016.7 8023.0 7593.9 7621.7 7701.9 7719.8 7883.8 12:56:45 INFO - PROCESS | 22630 | -------- Summary: end -------- 12:56:45 INFO - PROCESS | 22630 | 12:56:46 INFO - TEST-INFO | 22630: exit 0 12:56:46 INFO - TEST-OK | dromaeo_css | took 1116796ms 12:56:46 INFO - TEST-START | kraken 12:56:46 INFO - operating with platform_type : linux_ 12:56:46 INFO - Initialising browser for kraken test... 12:56:46 INFO - TEST-INFO | started process 22810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkcYfBd/profile http://localhost:38225/getInfo.html) 12:56:50 INFO - PROCESS | 22810 | __metrics Screen width/height:1600/1200 12:56:50 INFO - PROCESS | 22810 | colorDepth:24 12:56:50 INFO - PROCESS | 22810 | Browser inner width/height: 1024/697 12:56:50 INFO - PROCESS | 22810 | __metrics 12:56:51 ERROR - PROCESS | 22810 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:56:52 INFO - TEST-INFO | 22810: exit 0 12:56:52 INFO - Browser initialized. 12:56:52 INFO - Running cycle 1/1 for kraken test... 12:56:52 INFO - TEST-INFO | started process 22891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkcYfBd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:57:04 INFO - PROCESS | 22891 | RSS: Main: 155213824 12:57:04 INFO - PROCESS | 22891 | 12:57:07 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38225/tests/kraken/driver.html?testName=audio-beat-detection) 12:57:08 INFO - PROCESS | 22891 | RSS: Main: 195743744 12:57:08 INFO - PROCESS | 22891 | 12:57:10 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38225/tests/kraken/driver.html?testName=audio-dft) 12:57:11 INFO - PROCESS | 22891 | RSS: Main: 185462784 12:57:11 INFO - PROCESS | 22891 | 12:57:14 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38225/tests/kraken/driver.html?testName=audio-fft) 12:57:15 INFO - PROCESS | 22891 | RSS: Main: 172335104 12:57:15 INFO - PROCESS | 22891 | 12:57:17 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38225/tests/kraken/driver.html?testName=audio-oscillator) 12:57:17 INFO - PROCESS | 22891 | RSS: Main: 172756992 12:57:17 INFO - PROCESS | 22891 | 12:57:20 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:57:20 INFO - PROCESS | 22891 | RSS: Main: 173608960 12:57:20 INFO - PROCESS | 22891 | 12:57:23 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38225/tests/kraken/driver.html?testName=imaging-darkroom) 12:57:24 INFO - PROCESS | 22891 | RSS: Main: 173768704 12:57:24 INFO - PROCESS | 22891 | 12:57:27 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38225/tests/kraken/driver.html?testName=imaging-desaturate) 12:57:28 INFO - PROCESS | 22891 | RSS: Main: 175194112 12:57:28 INFO - PROCESS | 22891 | 12:57:31 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38225/tests/kraken/driver.html?testName=json-parse-financial) 12:57:31 INFO - PROCESS | 22891 | RSS: Main: 174813184 12:57:31 INFO - PROCESS | 22891 | 12:57:33 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:57:34 INFO - PROCESS | 22891 | RSS: Main: 183742464 12:57:34 INFO - PROCESS | 22891 | 12:57:35 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:57:36 INFO - PROCESS | 22891 | RSS: Main: 182083584 12:57:36 INFO - PROCESS | 22891 | 12:57:38 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:57:39 INFO - PROCESS | 22891 | RSS: Main: 192880640 12:57:39 INFO - PROCESS | 22891 | 12:57:41 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:57:42 INFO - PROCESS | 22891 | RSS: Main: 198938624 12:57:42 INFO - PROCESS | 22891 | 12:57:44 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:57:45 INFO - PROCESS | 22891 | RSS: Main: 198344704 12:57:45 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | Cycle 1(1): loaded http://localhost:38225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38225/tests/kraken/driver.html?testName=ai-astar) 12:57:47 INFO - PROCESS | 22891 | RSS: Main: 260411392 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | __start_tp_report 12:57:47 INFO - PROCESS | 22891 | _x_x_mozilla_page_load 12:57:47 INFO - PROCESS | 22891 | _x_x_mozilla_page_load_details 12:57:47 INFO - PROCESS | 22891 | |i|pagename|runs| 12:57:47 INFO - PROCESS | 22891 | |0;ai-astar;112;113;109;113;113;113;101;112;111;113 12:57:47 INFO - PROCESS | 22891 | |1;audio-beat-detection;160;138;159;187;142;162;160;133;189;133 12:57:47 INFO - PROCESS | 22891 | |2;audio-dft;160;161;163;161;160;161;160;162;161;162 12:57:47 INFO - PROCESS | 22891 | |3;audio-fft;73;73;110;97;75;77;73;111;105;74 12:57:47 INFO - PROCESS | 22891 | |4;audio-oscillator;93;95;146;93;93;93;145;93;94;140 12:57:47 INFO - PROCESS | 22891 | |5;imaging-gaussian-blur;116;117;116;117;116;117;116;116;119;117 12:57:47 INFO - PROCESS | 22891 | |6;imaging-darkroom;146;146;146;146;146;147;146;145;146;145 12:57:47 INFO - PROCESS | 22891 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;95;96 12:57:47 INFO - PROCESS | 22891 | |8;json-parse-financial;65;66;65;67;73;65;66;76;63;63 12:57:47 INFO - PROCESS | 22891 | |9;json-stringify-tinderbox;64;65;64;64;64;65;64;63;64;64 12:57:47 INFO - PROCESS | 22891 | |10;stanford-crypto-aes;83;84;84;84;82;90;82;84;82;84 12:57:47 INFO - PROCESS | 22891 | |11;stanford-crypto-ccm;127;122;121;125;117;116;119;118;123;126 12:57:47 INFO - PROCESS | 22891 | |12;stanford-crypto-pbkdf2;142;143;142;141;155;141;141;144;146;143 12:57:47 INFO - PROCESS | 22891 | |13;stanford-crypto-sha256-iterative;74;67;68;66;66;67;70;68;67;69 12:57:47 INFO - PROCESS | 22891 | __end_tp_report 12:57:47 INFO - PROCESS | 22891 | __start_cc_report 12:57:47 INFO - PROCESS | 22891 | _x_x_mozilla_cycle_collect,1180 12:57:47 INFO - PROCESS | 22891 | __end_cc_report 12:57:47 INFO - PROCESS | 22891 | __startTimestamp1459627067523__endTimestamp 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | ------- Summary: start ------- 12:57:47 INFO - PROCESS | 22891 | Number of tests: 14 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.74 (3.3%) stddev-sans-first:3.95 12:57:47 INFO - PROCESS | 22891 | Values: 112.0 113.0 109.0 113.0 113.0 113.0 101.0 112.0 111.0 113.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:160.00 stddev:20.29 (12.7%) stddev-sans-first:21.47 12:57:47 INFO - PROCESS | 22891 | Values: 160.0 138.0 159.0 187.0 142.0 162.0 160.0 133.0 189.0 133.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 12:57:47 INFO - PROCESS | 22891 | Values: 160.0 161.0 163.0 161.0 160.0 161.0 160.0 162.0 161.0 162.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#3] audio-fft Cycles:10 Average:86.80 Median:73.50 stddev:16.77 (22.8%) stddev-sans-first:17.02 12:57:47 INFO - PROCESS | 22891 | Values: 73.0 73.0 110.0 97.0 75.0 77.0 73.0 111.0 105.0 74.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:24.32 (26.2%) stddev-sans-first:25.14 12:57:47 INFO - PROCESS | 22891 | Values: 93.0 95.0 146.0 93.0 93.0 93.0 145.0 93.0 94.0 140.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 12:57:47 INFO - PROCESS | 22891 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 119.0 117.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:57:47 INFO - PROCESS | 22891 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 145.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 12:57:47 INFO - PROCESS | 22891 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:66.00 stddev:4.25 (6.4%) stddev-sans-first:4.46 12:57:47 INFO - PROCESS | 22891 | Values: 65.0 66.0 65.0 67.0 73.0 65.0 66.0 76.0 63.0 63.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 12:57:47 INFO - PROCESS | 22891 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 64.0 63.0 64.0 64.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:2.33 (2.8%) stddev-sans-first:2.45 12:57:47 INFO - PROCESS | 22891 | Values: 83.0 84.0 84.0 84.0 82.0 90.0 82.0 84.0 82.0 84.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:3.86 (3.2%) stddev-sans-first:3.53 12:57:47 INFO - PROCESS | 22891 | Values: 127.0 122.0 121.0 125.0 117.0 116.0 119.0 118.0 123.0 126.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:143.00 stddev:4.24 (3.0%) stddev-sans-first:4.44 12:57:47 INFO - PROCESS | 22891 | Values: 142.0 143.0 142.0 141.0 155.0 141.0 141.0 144.0 146.0 143.0 12:57:47 INFO - PROCESS | 22891 | 12:57:47 INFO - PROCESS | 22891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.39 (3.5%) stddev-sans-first:1.33 12:57:47 INFO - PROCESS | 22891 | Values: 74.0 67.0 68.0 66.0 66.0 67.0 70.0 68.0 67.0 69.0 12:57:47 INFO - PROCESS | 22891 | -------- Summary: end -------- 12:57:47 INFO - PROCESS | 22891 | 12:57:48 INFO - TEST-INFO | 22891: exit 0 12:57:48 INFO - TEST-OK | kraken | took 62289ms 12:57:48 INFO - SUITE-END | took 1179s 12:57:48 INFO - Completed test suite (00:19:39) 12:57:48 INFO - javascript benchmark 12:57:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2580.8580528070956, 2678.0745687256544, 2685.785137189025, 2694.12440956689, 2720.993232503973, 4588.2658774596075, 4601.930971035437, 4623.884402889929, 4659.464161621415, 4666.626669866411, 4618.491965883759, 4640.350350950869, 4661.627069834413, 4697.084068606615, 4705.505921878204, 4236.216299984498, 4243.618074373306, 4281.229378711831, 4310.741355518679, 4375.453068366454, 4324.243257429937, 4349.151915376503, 4350.477942646871, 4379.540148284432, 4396.120775844828, 4183.6234738873345, 4194.958050419487, 4270.829166833339, 4277.743335399886, 4287.421198138242, 4295.8496452624, 4303.526612072669, 4304.182205380967, 4347.608715215614, 4354.9564504355185, 4257.638100761408, 4269.338252570857, 4277.358396240557, 4285.442892423996, 4319.719218250803, 4422.6682998774895, 4454.955450445519, 4526.6831321807485, 4539.160255352737, 4580.244259697146, 5002.349694539723, 5002.59979201663, 5004.499550045003, 5005.974970125162, 5011.0, 5020.799168033274, 5022.296878437021, 5031.723255220962, 5038.949610503884, 5081.034603425337, 4595.793189306522, 4627.051454451829, 4692.0, 4699.060187962421, 4710.528947105262, 5080.212567052113, 5100.846974590768, 5109.4379618241965, 5123.103456895028, 5150.536451719363, 4921.7785199666105, 4935.840077581765, 4941.135301322254, 4942.57988071018, 4990.8752281193265, 4885.2427873679635, 4958.082754690394, 5006.098902197639, 5020.673656212334, 5055.292259083732, 4968.4286307075145, 4969.080720066727, 4978.27814966835, 4979.078870408914, 4990.351254336913, 4922.0, 4938.25926111079, 4942.851714448572, 4948.8762780930765, 4968.254761785761, 4091.7544947302663, 4170.666346692257, 4174.144300418407, 4179.164167166578, 4247.108107297502, 3698.130939229279, 3706.4069748840056, 3724.2365315110337, 3730.981345093257, 3738.5887552369218, 4272.33778764292, 4306.20335237982, 4310.482742070972, 4310.827566897352, 4314.935275970863, 4979.950200498021, 4982.352294201731, 4985.725785081855, 4993.27597498368, 5019.899602007939, 4304.139172165579, 4306.397104405386, 4309.91380172401, 4335.82656693735, 4352.347147927836, 4361.193179261847, 4418.138462999748, 4450.443694538183, 4459.576340247736, 4510.985028368591, 4675.6259499239295, 4702.506236845082, 4703.905921881543, 4705.929411058837, 4750.643701722384, 4895.681780684244, 4897.412310522617, 4940.802367905244, 4946.3817022872145, 4987.750612469289, 4651.558101980307, 4676.532346765296, 4686.062787442457, 4690.765461726832, 4712.552307530779, 4872.512748725099, 4911.287863259879, 4929.334539837219, 4936.8765780855765, 4949.777260023236, 4936.580390666833, 4939.259111133359, 4941.827036053721, 4943.629227808001, 4977.751112444291, 4682.461516925598, 4741.9051618968115, 4819.204831202812, 4829.106615276185, 4832.903341933212, 4816.373871396696, 4832.540908613676, 4836.879078023077, 4849.660523763303, 4887.242477416006, 4715.0805592909055, 4761.40482439695, 4776.259679749644, 4779.354787103696, 4815.566599006106, 4704.153252414599, 4807.711537307773, 4847.5394837490385, 4889.168841297059, 4902.2156454967035, 4726.220173671306, 4733.479317275166, 4749.216379297377, 4755.120302743865, 4793.520647935318], "unit": "score", "name": "dojo.html", "value": 4569.86235020821}, {"lowerIsBetter": false, "replicates": [529.9046171689097, 532.5845840244608, 537.508180015286, 541.8536995011347, 550.6530885542107, 26033.869830650845, 33630.15924601886, 34372.65627343729, 34492.827535862285, 34535.96392108241, 35992.0, 36466.817665911636, 36468.0, 36476.27047459056, 36488.81755591225, 7457.925420745804, 7625.809354766147, 7627.923720762777, 7631.694732210705, 7634.5037572557885, 6498.382653647919, 7801.609919504031, 7802.21977802218, 7802.414818888606, 7802.960985195066, 7755.650995705207, 7815.882761758578, 7821.061472623264, 7827.178146294643, 7828.256315650005, 7732.536047837119, 7797.76606701797, 7810.453268271223, 7819.530828150329, 7822.1786712395515, 7739.6904123834975, 7860.410469214832, 7861.646225919847, 7864.724734634317, 7864.960675196645, 37902.43146352807, 38227.23545529102, 38301.80849095764, 38343.80828095869, 38456.80771596152, 3021.350409661933, 3115.766317526172, 3255.7720959532844, 3494.4583589543663, 3850.8459661613783, 28733.712662873313, 28744.281392965135, 28927.0, 29161.854190729122, 29576.704232957825, 3369.6124945631323, 3410.3179364127272, 3465.2549701813978, 3491.336646037245, 3517.718582513393, 242421.0, 243658.0, 243900.0, 244988.0, 245104.0, 47520.5247947523, 48335.516644833806, 54196.0, 54474.45525544694, 54608.72695636576, 47808.28287575689, 48417.273740893914, 48428.27357589639, 48524.51475485271, 48544.514554854, 14029.859701402855, 14030.228337441335, 14103.294835258195, 14151.221682807338, 14169.079009864327, 8857.512836793909, 10610.628627997983, 10612.57549698019, 11153.330800152016, 11361.94319028416, 17583.912080439517, 17819.10904454772, 17940.730889036677, 17945.0, 17994.460166195036, 6760.1549806274215, 6763.323667633197, 6909.343612356919, 6929.41100006495, 7049.859002819915, 922.1331947968888, 931.8462453695064, 934.4066517761134, 978.814025335184, 1055.2929537210089, 26161.0, 26373.0, 26676.73323266781, 27323.726762732516, 27332.316692082855, 981.5582987655583, 984.5323471351194, 1023.7287118913493, 1024.206240163864, 1033.0289527843802, 13834.30828458573, 14080.295985200699, 14094.154350738989, 14544.709105817825, 14560.85439145595, 273174.0, 274870.0, 277013.0, 277735.0, 278175.0, 47734.28398574024, 48055.5194448058, 48089.5191048092, 48147.518524815, 48165.518344816104, 1050.1336397472116, 1105.1987309200927, 1203.6148432501516, 1227.0, 1234.0682784497826, 25825.870870645525, 25897.482050359264, 26284.474310514066, 26393.472130557664, 26654.333641659112, 32494.187645309055, 32626.184345391554, 32757.836210818794, 32812.0, 32836.34327313488, 172057.0, 172087.0, 172329.0, 173083.13458432627, 173123.0, 26412.0, 29804.552931706476, 31074.378512430078, 31186.844065779525, 31794.0, 34765.65234347624, 34824.303513930085, 35571.466428003085, 35849.0, 35930.101747455476, 30150.396992060476, 30213.697863021087, 30541.847290763402, 30880.69119308868, 30989.845050774602, 29224.707752922197, 29708.257293567833, 30139.69860301369, 30307.545386818776, 30700.692993070676, 32770.67229327676, 33255.667443325256, 33305.500417494244, 33668.65325386957, 33675.326493470486, 29300.413991720474, 29400.7059929398, 29430.705692942796, 29558.0, 29676.25809354697, 23448.0, 23950.401239969142, 24099.397515062265, 24177.879110604335, 24684.876575617007], "unit": "score", "name": "ext.html", "value": 16353.66766062336}, {"lowerIsBetter": false, "replicates": [350.8508883724417, 352.41589057187946, 356.6522640425585, 365.16377495535227, 365.2712837888411, 15560.53318400447, 15613.86944814943, 17081.829181708163, 17320.0, 17335.306587736508, 16209.432669856527, 16544.255508502116, 16842.0736859473, 16849.241784119746, 16860.241289141988, 4813.205821039524, 4947.7031378117335, 4984.077945580079, 5031.874203144932, 5036.294918711384, 4914.1400254955415, 4977.701337919736, 4979.551840334369, 4996.5503104720565, 5030.06943715412, 4896.1186986342445, 4932.506749325074, 4933.407991041062, 4937.210046392578, 5002.424721157059, 5148.5881129509735, 5150.639455238135, 5183.118869792144, 5187.8443646690475, 5189.195674670414, 4987.177115775893, 5002.499750025005, 5002.699838009731, 5005.924911126336, 5008.048470790538, 11102.222844400896, 11660.941695291554, 11662.416879156093, 11667.474963626657, 11672.35802030888, 1820.8907465551977, 1879.830815226636, 1881.3133206379573, 1882.9905850470798, 1949.0157470477318, 8454.450460720034, 8809.471431714117, 10972.835407468894, 12491.812622810665, 12961.351932403342, 1713.3146741303578, 1720.81931397204, 1727.136431784108, 1764.0650455258733, 1792.4801807475817, 53970.730146349015, 55492.0, 57872.13191802127, 59143.40856591422, 60116.69941650264, 9415.764605884908, 9436.71689849292, 9550.570224339921, 9612.615495380247, 9789.0, 12826.23042617446, 12872.22766634005, 12882.355882205853, 12930.418131184118, 12931.806022909665, 7010.824729381806, 7098.574085554883, 7109.857802844018, 7242.601656908815, 7267.63661816907, 6939.0, 6966.442684585221, 6971.965140174369, 6980.092587963532, 7039.401650859734, 4105.281575724236, 4166.541680415152, 4205.36919462077, 4244.575542445731, 4258.318669012943, 1632.7061128996895, 1642.901425914425, 1706.590418299624, 1754.8069712331633, 1758.3581992572874, 763.5342441110918, 772.1737740617598, 805.5126648377765, 806.6249194124761, 832.0431503770712, 14487.49293774734, 14894.329755161043, 14894.776578351333, 14968.850311496746, 15043.849561504245, 794.9324307433933, 800.5756948817136, 828.0973738624928, 830.5722552885269, 845.1084106267946, 8701.869471957925, 8769.254613357936, 8919.331050171264, 8994.550272486349, 9022.684206052756, 381995.0, 394262.0, 395449.0, 395839.0, 395844.0, 65890.0, 66298.66850665715, 67086.30395872242, 67185.66407167933, 67819.66090169517, 952.7760976170595, 965.2567523007385, 965.3676841668719, 975.302658599105, 1012.7063151685928, 14021.8782497402, 14119.505817296345, 14364.784528231876, 14455.060421072596, 14591.197484138474, 29455.705442946153, 31052.534211986385, 33316.66683333136, 33664.3267134651, 35252.47121293234, 45024.54975450203, 47989.0, 48009.5199048019, 48081.52344196776, 48146.759266203444, 7134.714611415693, 7147.356737893615, 7202.96398518004, 7262.346388825031, 7274.127104747464, 6921.792346229621, 8792.98880628736, 9129.589168487566, 11430.11349155169, 11677.357745324089, 9759.512024398893, 9973.650922217977, 10060.547275372772, 10451.714866483515, 10660.62687805923, 9861.457619830979, 9991.25065620067, 10043.899561004297, 10102.242331824995, 10401.479926003822, 9866.358686685342, 9942.701718948443, 10265.538050787583, 10505.212109091695, 10623.415712135908, 7224.0, 7239.565626062453, 7254.746083887038, 7418.8145296365865, 7476.364509016795, 8603.69887053975, 9760.755981100529, 9946.701598952042, 10057.396556206651, 10079.24405669563], "unit": "score", "name": "jquery.html", "value": 7696.54448319168}, {"lowerIsBetter": false, "replicates": [1279.027938766537, 1338.511443323187, 1352.513095285697, 1492.3135357735441, 1725.3184991928188, 6538.248101468333, 6991.056207411998, 7207.675654595542, 7211.7475888343915, 7217.530860494065, 7073.469489788261, 7219.133703955519, 7229.313215244557, 7230.9276907230915, 7238.638068096588, 1884.3498992847447, 1936.845052395812, 2128.946776330589, 2191.660292654641, 2232.0402227042364, 2201.2955854126685, 2209.591225623257, 2210.3368989303226, 2211.215018668374, 2212.5685491329195, 2073.8859362735043, 2099.254764558583, 2113.2392338758114, 2148.226638410179, 2149.5485947950947, 2142.9464263393384, 2174.3694328644674, 2186.1364760919428, 2189.6496560550236, 2191.671249312608, 2190.8028277454946, 2204.239537359608, 2209.3371988403414, 2210.2264207527237, 2211.900464479102, 7405.222451642554, 7443.330100290946, 7443.851122977564, 7446.441516886201, 7458.179600243969, 4486.641068714495, 4575.359449677047, 4576.931346029813, 4599.609033232179, 4604.654650901196, 2788.776897848167, 2966.2732630505448, 2967.866446009935, 2990.177701132206, 3002.654694710093, 880.2913654508119, 928.4661319741176, 931.8229536388064, 950.1686024728363, 957.090763774417, 10171.033751793568, 10175.084242418145, 10187.949060254725, 10195.0, 10195.541200645914, 4029.81865816039, 4042.8787136385954, 4110.0752330725345, 4135.421041054195, 4135.545090040093, 8752.124787521198, 8760.386772925962, 8764.342674299452, 8771.0, 8778.736637900873, 4617.2612382018715, 4634.21218392874, 4634.768261586907, 4649.511801260886, 4655.092257009851, 3638.872639457606, 3775.8300876460075, 4001.039750459927, 4175.081482073939, 4207.1375368050085, 3483.8083905385447, 3512.4906888501023, 3522.313148935984, 3561.2521370511963, 3591.425371940477, 1137.181229514748, 1138.9373584452935, 1142.5829572206085, 1158.3397463445924, 1158.6408213453856, 972.397113789455, 993.3195760903805, 1170.4674373160192, 1191.2614179208947, 1197.694587880085, 6817.113775209191, 6845.623490707959, 6852.486063545254, 6867.175938887365, 6878.69045892936, 1107.8670559532748, 1117.9776404471866, 1152.5965911930757, 1155.5204590095184, 1166.3701601135463, 5337.759800808973, 5494.532964698045, 5498.780048798083, 5504.119340905436, 5512.586556008316, 8696.17386348296, 8928.241099506486, 9110.954445227864, 9111.0, 9358.766030849283, 9047.864282035775, 9142.131497507859, 9189.954050229706, 9232.584533696, 9242.983271840092, 6948.583085014915, 6997.265287144878, 7106.289371062852, 7121.501494895308, 7172.892406613801, 6722.932770672426, 6753.15585551806, 6815.318468153145, 6817.863642727217, 6832.180138383425, 7934.484258523177, 8079.555624440713, 8080.83838323242, 8173.959130204311, 8316.708915187939, 8139.267465928095, 8289.626966786629, 8374.330053595819, 8388.119247478928, 8523.659053637784, 5437.26596909428, 5795.797147099831, 6016.819495415145, 6129.141920131096, 6204.007358822567, 6883.070785443901, 6902.516823822485, 6948.861022779617, 6952.721891124298, 6961.79114626562, 6118.510519158368, 6248.4376406123665, 6262.405071518198, 6304.936950630435, 6344.460720838596, 5979.0, 6073.908891366545, 6077.453029227391, 6144.631322120687, 6192.504599632109, 6710.261871194067, 6762.222344430454, 6787.423069039187, 6798.796036118924, 6809.319068093349, 6047.03247480401, 6121.173641558333, 6125.326214116354, 6157.815265542041, 6167.414095660905, 6271.3415091414745, 6431.839204019937, 6434.903476447764, 6435.292117867125, 6438.259600145856], "unit": "score", "name": "mootools.html", "value": 4259.493547240379}, {"lowerIsBetter": false, "replicates": [318.3339531424321, 318.4617995587457, 323.1871842316574, 324.09092495550004, 325.50035695207845, 5225.8954820903555, 5260.500252476014, 5351.919721204185, 5354.544863686581, 5363.570914326854, 5212.921806172911, 5269.235960785693, 5269.394019687737, 5271.736413179345, 5294.179402192657, 3966.0679740261016, 4031.6169963853386, 4120.052387950758, 4150.3359462486005, 4164.583541645841, 4130.586941305875, 4147.108371700099, 4148.502179738421, 4152.086540960984, 4159.83360665573, 4091.8158682859344, 4092.9386059209137, 4101.871985204063, 4106.938395924063, 4107.199096176247, 3907.8241479133367, 3974.225026119908, 3995.20095980805, 4076.7961601919787, 4105.363668631367, 3604.693601043888, 3609.8917032489067, 3616.385214513539, 3617.8914632561064, 3618.4029635110173, 4996.875078123039, 4999.975000125012, 5007.399112106534, 5007.4491805901325, 5021.748912554394, 4711.623070154379, 4713.104510143062, 4715.316279139505, 4716.151092803294, 4729.881752956169, 5485.0949593317455, 5495.780168793243, 5497.47773961473, 5501.0, 5506.394296627408, 3965.643092121723, 3974.741641793274, 3978.681705463585, 3979.5622481527007, 3980.2835489611857, 5579.461345088016, 5760.107183386582, 5810.477057064884, 5832.416758324176, 5837.445442682938, 3956.1889812588925, 3964.1080756829483, 3981.5222173338807, 3985.103351745834, 3988.641022308006, 4007.278689835799, 4023.5574086850424, 4040.070783719761, 4046.109855831712, 4046.433499310099, 4634.397528321364, 4637.39713837199, 4645.396098507173, 4645.535446455395, 4650.395448591729, 5563.0, 5564.638298510665, 5569.359523654751, 5574.58190635704, 5582.441755824385, 1398.6713122416224, 1413.9010269281257, 1421.3106643278002, 1424.6367176370165, 1425.5438259756986, 937.920276776468, 951.1107114847501, 959.6737109382843, 970.1171933540444, 974.2498276327188, 4768.117898188846, 4821.975890120597, 4905.975470122627, 4918.729469879119, 4924.704517728947, 5751.424857514299, 5773.769049238067, 5778.508826749773, 5780.306363236438, 5830.650160990354, 4892.2661600760175, 4942.357493525818, 4943.901121977612, 4952.182889823211, 4953.281774142729, 3078.984605077005, 3092.7835051546626, 3101.5037593984853, 3120.095172400024, 3122.5160100184507, 5434.483724046209, 5471.042567550663, 5472.835814925558, 5472.91790623141, 5493.835184944458, 5782.624129431573, 5897.144913987534, 5973.820785376446, 5981.3719559445635, 5981.970090149522, 5474.425185355481, 5490.094134467848, 5493.752781124859, 5495.670259784346, 5508.366537848199, 5759.769609215585, 5764.452377024176, 5779.162021506774, 5783.6818974955095, 5790.160426738184, 5642.069058605284, 5688.203651488712, 5694.658320500783, 5700.144978253129, 5706.372299047019, 5453.536449401845, 5480.369757477941, 5483.259759932358, 5485.6982865942755, 5492.725363731717, 3857.440671102618, 3935.2916475034767, 3984.900377490586, 3990.74060186087, 3991.92016159681, 5656.321241451053, 5696.287964004499, 5698.857528561653, 5738.799142030176, 5743.569232307677, 5552.000639884859, 5555.916661250004, 5568.721563921868, 5571.08077167279, 5575.135853942646, 5554.583406244467, 5573.470520300565, 5588.133839254922, 5590.580706447114, 5591.356993945748, 5436.592255580927, 5463.289772329572, 5479.150731636602, 5480.6437581557075, 5481.314835645544, 5445.50990410849, 5585.134304182858, 5598.916016259678, 5603.075492543685, 5613.719314034363, 5426.593005524523, 5466.91799622998, 5470.288862447856, 5473.616846820684, 5485.9725701371235], "unit": "score", "name": "prototype.html", "value": 4187.254894736371}, {"lowerIsBetter": false, "replicates": [626.9279032911211, 652.9738810447583, 753.8153152477643, 762.3139174742735, 773.2808488106061, 11393.316401015934, 11502.597409090684, 13618.591442256748, 13905.860941390583, 13922.582322530316, 12920.870791292084, 12923.80614290784, 12939.805902911441, 12957.805632915513, 13042.60872173834, 650.5868773328923, 655.9540832141752, 804.0753133896037, 808.5593351623379, 823.5305875650881, 800.2517646000979, 807.8222790985974, 809.7327881798992, 813.1461964936822, 813.5403497024192, 841.5960339037235, 847.1909326593088, 847.6948298612494, 847.9364047696416, 848.1264297773273, 624.8063100438856, 834.1283358889945, 836.2599099796663, 839.0434904209206, 843.9113893041203, 615.5291202230297, 616.315889362807, 616.7779599344233, 617.0127795527121, 617.237711426388, 12098.0, 12122.454489547992, 12213.389330533439, 12221.0, 12235.571754988532, 11051.778964420666, 11374.71563210918, 11397.772044559146, 12058.457369418396, 12258.938705306417, 9619.51902404877, 9812.215022798158, 9845.753856153653, 9866.753331166707, 9929.702108936743, 3302.53764472974, 3363.3105213431186, 3382.8815991440183, 3383.915402114942, 3403.149212696826, 43958.0, 44106.77946610247, 44229.115417691784, 44505.777471112764, 44520.0, 8844.646214151491, 9074.183323500916, 9133.543322833832, 9851.310408271353, 9935.254855885838, 16431.835681643268, 16440.342386304415, 16446.095464749553, 16649.50051498457, 16659.16704164787, 6358.109864618957, 6485.156929599217, 6882.759103431456, 7008.369246767816, 7251.963740181265, 3716.7212459065677, 3729.310077635646, 3741.345264578688, 3746.68153206975, 3757.4176002719623, 2733.3303340681264, 2734.111413790526, 2734.8495832728995, 2752.518309295865, 2763.585462180689, 521.5254118751993, 537.0279793573644, 543.4348277791132, 544.1076634319719, 547.1300631995147, 508.6083715539014, 605.8848818724429, 606.236142460503, 628.7139351595014, 639.2297281775542, 8103.635336409876, 8473.152684731478, 8534.27458666008, 8585.441946273471, 8593.570321484025, 605.9697015149313, 607.5807692692028, 617.5079923035242, 623.6632218601904, 631.4948041566728, 3863.188730366598, 3865.3235683755793, 3921.764694118362, 3975.1254723960683, 4097.713160078825, 51649.225261621104, 52126.478735212164, 52814.0, 52868.73565632147, 53260.73369633127, 45820.77089614597, 46028.539714603095, 46294.0, 46639.06721865611, 47030.76484617624, 41518.58481415208, 41527.0, 42025.159496809894, 42346.57653423488, 42416.0, 7979.521228726295, 8047.436679432383, 8104.635291411782, 8142.0, 8243.670253189804, 32009.359812803148, 32036.67963320337, 32426.0, 32985.67014329826, 33537.0, 37551.43672844855, 37677.4348384769, 40038.79980600078, 40998.385024224066, 41658.79170604127, 9436.622535098519, 9504.097110774464, 9508.809823803347, 9779.706608801747, 9839.065288797552, 10716.19628527848, 10767.6231331903, 11026.117910567296, 11027.17296202772, 11177.497012634614, 10032.548535315782, 10125.088742013255, 10194.643187488402, 10249.538770755484, 10380.844287335545, 8953.776155596162, 8974.102589741235, 9063.501507417155, 9341.906580934103, 9509.66716164931, 9805.362651427635, 9929.702108936743, 10194.133498652698, 10204.795904081728, 10234.948825255826, 7653.923460765321, 7759.262870027338, 7822.0, 8016.7194148204535, 8022.9598852005365, 7593.924060759322, 7621.733239336597, 7701.922980770345, 7719.8070048247, 7883.802904927423], "unit": "score", "name": "yui.html", "value": 5790.67280148354}], "name": "dromaeo_css", "value": 6246.623523666325}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 109.0, 113.0, 113.0, 113.0, 101.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [160.0, 138.0, 159.0, 187.0, 142.0, 162.0, 160.0, 133.0, 189.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 156.3}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 163.0, 161.0, 160.0, 161.0, 160.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 110.0, 97.0, 75.0, 77.0, 73.0, 111.0, 105.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 146.0, 93.0, 93.0, 93.0, 145.0, 93.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 119.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 67.0, 73.0, 65.0, 66.0, 76.0, 63.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 66.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 82.0, 90.0, 82.0, 84.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 121.0, 125.0, 117.0, 116.0, 119.0, 118.0, 123.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 142.0, 141.0, 155.0, 141.0, 141.0, 144.0, 146.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [74.0, 67.0, 68.0, 66.0, 66.0, 67.0, 70.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1529.9}]} 12:57:48 INFO - Return code: 0 12:57:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:57:48 ERROR - # TBPL SUCCESS # 12:57:48 INFO - Running post-action listener: _resource_record_post_action 12:57:48 INFO - Running post-run listener: _resource_record_post_run 12:57:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 529031168; Read time: 0; Write time: 548680 12:57:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 186331136; Read time: 0; Write time: 243496 12:57:49 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 284848128; Read time: 0; Write time: 283216 12:57:49 INFO - Running post-run listener: _upload_blobber_files 12:57:49 INFO - Blob upload gear active. 12:57:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:57:49 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 12:57:49 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'] 12:57:49 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 12:57:50 INFO - (blobuploader) - INFO - Open directory for files ... 12:57:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:57:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:57:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:57:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:57:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:57:51 INFO - (blobuploader) - INFO - Done attempting. 12:57:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:57:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:57:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:57:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:57:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:57:52 INFO - (blobuploader) - INFO - Done attempting. 12:57:52 INFO - (blobuploader) - INFO - Iteration through files over. 12:57:52 INFO - Return code: 0 12:57:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:57:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:57:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7962ee7f6adcf5cf76c7e511e44191254af4e328e9259b6fd0c94e9c0216afcc3aa28193c55cc221da805c5f60130da652b390b4e2223257c5d7f044f4323f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70a5dfed49ad2fad9c9208adb92a7866c9c3e7d90a3864291a3512a40fb5e7aea7e5afe6f72c7a3768c698ffda1a230e532bb38c6bd4b0a5ae15af96c830ea4e"} 12:57:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:57:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:57:52 INFO - Contents: 12:57:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7962ee7f6adcf5cf76c7e511e44191254af4e328e9259b6fd0c94e9c0216afcc3aa28193c55cc221da805c5f60130da652b390b4e2223257c5d7f044f4323f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70a5dfed49ad2fad9c9208adb92a7866c9c3e7d90a3864291a3512a40fb5e7aea7e5afe6f72c7a3768c698ffda1a230e532bb38c6bd4b0a5ae15af96c830ea4e"} 12:57:52 INFO - Running post-run listener: copy_logs_to_upload_dir 12:57:52 INFO - Copying logs to upload dir... 12:57:52 INFO - mkdir: /builds/slave/test/build/upload/logs 12:57:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.820041 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-02 12:57:51.859158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 12:57:51.863101) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 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/7962ee7f6adcf5cf76c7e511e44191254af4e328e9259b6fd0c94e9c0216afcc3aa28193c55cc221da805c5f60130da652b390b4e2223257c5d7f044f4323f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70a5dfed49ad2fad9c9208adb92a7866c9c3e7d90a3864291a3512a40fb5e7aea7e5afe6f72c7a3768c698ffda1a230e532bb38c6bd4b0a5ae15af96c830ea4e"} build_url:https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/KdEQt0NbRxC4FSrpiIQjrg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7962ee7f6adcf5cf76c7e511e44191254af4e328e9259b6fd0c94e9c0216afcc3aa28193c55cc221da805c5f60130da652b390b4e2223257c5d7f044f4323f2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70a5dfed49ad2fad9c9208adb92a7866c9c3e7d90a3864291a3512a40fb5e7aea7e5afe6f72c7a3768c698ffda1a230e532bb38c6bd4b0a5ae15af96c830ea4e"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 12:57:51.951124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:57:51.951448) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1459625646.795204-2092740687 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:57:52.086042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 12:57:52.086349) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 12:57:52.086675) ========= ========= Total master_lag: 0.43 =========