builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1457697367.34 results: success (0) buildid: 20160311031816 builduid: 14b671a5fad341eebe7d2c80535f1fbc revision: f7ed458ec73dc42d58fda3d69b1036738d968833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.340095) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.340499) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.340980) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006277 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.370549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.370879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.429726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.430042) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.479062) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.479328) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.482692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.482991) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-11 03:56:07-- 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% 229M=0s 2016-03-11 03:56:07 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.650155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.650454) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017445 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.703107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:07.703473) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f7ed458ec73dc42d58fda3d69b1036738d968833 --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 f7ed458ec73dc42d58fda3d69b1036738d968833 --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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-11 03:56:07,826 truncating revision to first 12 chars 2016-03-11 03:56:07,826 Setting DEBUG logging. 2016-03-11 03:56:07,826 attempt 1/10 2016-03-11 03:56:07,826 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f7ed458ec73d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 03:56:08,103 unpacking tar archive at: fx-team-f7ed458ec73d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:08.314365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:08.314685) ========= echo f7ed458ec73dc42d58fda3d69b1036738d968833 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f7ed458ec73dc42d58fda3d69b1036738d968833'] 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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f7ed458ec73dc42d58fda3d69b1036738d968833 program finished with exit code 0 elapsedTime=0.004766 script_repo_revision: 'f7ed458ec73dc42d58fda3d69b1036738d968833' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:08.366415) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:08.366726) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 03:56:08.377404) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-11 03:56:08.377701) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:56:08 INFO - MultiFileLogger online at 20160311 03:56:08 in /builds/slave/test 03:56:08 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 03:56:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:56:08 INFO - {'append_to_log': False, 03:56:08 INFO - 'base_work_dir': '/builds/slave/test', 03:56:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:56:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:56:08 INFO - 'branch': 'Fx-Team-Non-PGO', 03:56:08 INFO - 'buildbot_json_path': 'buildprops.json', 03:56:08 INFO - 'config_files': ('talos/linux_config.py',), 03:56:08 INFO - 'default_actions': ('clobber', 03:56:08 INFO - 'read-buildbot-config', 03:56:08 INFO - 'download-and-extract', 03:56:08 INFO - 'populate-webroot', 03:56:08 INFO - 'create-virtualenv', 03:56:08 INFO - 'install', 03:56:08 INFO - 'run-tests'), 03:56:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:56:08 INFO - 'download_minidump_stackwalk': True, 03:56:08 INFO - 'download_symbols': 'ondemand', 03:56:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:56:08 INFO - 'tooltool.py': '/tools/tooltool.py', 03:56:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:56:08 INFO - '/tools/misc-python/virtualenv.py')}, 03:56:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:56:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:56:08 INFO - 'installer_path': 'installer.exe', 03:56:08 INFO - 'log_level': 'info', 03:56:08 INFO - 'log_name': 'talos', 03:56:08 INFO - 'log_to_console': True, 03:56:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:56:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:56:08 INFO - 'opt_config_files': (), 03:56:08 INFO - 'pip_index': False, 03:56:08 INFO - 'sps_profile': False, 03:56:08 INFO - 'sps_profile_interval': 0, 03:56:08 INFO - 'suite': 'dromaeojs', 03:56:08 INFO - 'system_bits': '32', 03:56:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:56:08 INFO - 'title': 'talos-linux64-ix-057', 03:56:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:56:08 INFO - 'use_talos_json': True, 03:56:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:56:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:56:08 INFO - 'work_dir': 'build'} 03:56:08 INFO - ##### 03:56:08 INFO - ##### Running clobber step. 03:56:08 INFO - ##### 03:56:08 INFO - Running pre-action listener: _resource_record_pre_action 03:56:08 INFO - Running main action method: clobber 03:56:08 INFO - rmtree: /builds/slave/test/build 03:56:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:56:09 INFO - Running post-action listener: _resource_record_post_action 03:56:09 INFO - ##### 03:56:09 INFO - ##### Running read-buildbot-config step. 03:56:09 INFO - ##### 03:56:09 INFO - Running pre-action listener: _resource_record_pre_action 03:56:09 INFO - Running main action method: read_buildbot_config 03:56:09 INFO - Using buildbot properties: 03:56:09 INFO - { 03:56:09 INFO - "project": "", 03:56:09 INFO - "product": "firefox", 03:56:09 INFO - "script_repo_revision": "production", 03:56:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:56:09 INFO - "repository": "", 03:56:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:56:09 INFO - "buildid": "20160311031816", 03:56:09 INFO - "pgo_build": "False", 03:56:09 INFO - "basedir": "/builds/slave/test", 03:56:09 INFO - "buildnumber": 2627, 03:56:09 INFO - "slavename": "talos-linux64-ix-057", 03:56:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:56:09 INFO - "platform": "ubuntu64_hw", 03:56:09 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:56:09 INFO - "branch": "fx-team", 03:56:09 INFO - "repo_path": "integration/fx-team", 03:56:09 INFO - "revision": "f7ed458ec73dc42d58fda3d69b1036738d968833", 03:56:09 INFO - "stage_platform": "linux64", 03:56:09 INFO - "builduid": "14b671a5fad341eebe7d2c80535f1fbc", 03:56:09 INFO - "slavebuilddir": "test" 03:56:09 INFO - } 03:56:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 03:56:09 INFO - Running post-action listener: _resource_record_post_action 03:56:09 INFO - ##### 03:56:09 INFO - ##### Running download-and-extract step. 03:56:09 INFO - ##### 03:56:09 INFO - Running pre-action listener: _resource_record_pre_action 03:56:09 INFO - Running main action method: download_and_extract 03:56:09 INFO - mkdir: /builds/slave/test/build/tests 03:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:09 INFO - https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:11 INFO - Downloaded 1361 bytes. 03:56:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 03:56:11 INFO - Using the following test package requirements: 03:56:11 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:56:11 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:56:11 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:56:11 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'jsshell-linux-x86_64.zip'], 03:56:11 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:56:11 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 03:56:11 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:56:11 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:56:11 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:56:11 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 03:56:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:56:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:56:11 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')]} 03:56:11 INFO - https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:56:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:56:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:56:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:17 INFO - Downloaded 22093190 bytes. 03:56:17 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'] 03:56:17 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 03:56:19 INFO - Return code: 0 03:56:19 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 03:56:19 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')]} 03:56:19 INFO - https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:56:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:56:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 03:56:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:25 INFO - Downloaded 22093190 bytes. 03:56:25 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'] 03:56:25 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 03:56:26 INFO - Return code: 0 03:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:26 INFO - https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 03:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:28 INFO - Downloaded 10845161 bytes. 03:56:28 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'] 03:56:28 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 03:56:28 INFO - Return code: 0 03:56:28 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')]} 03:56:28 INFO - https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:56:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:56:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:56:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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 03:56:30 INFO - Downloaded 54453419 bytes. 03:56:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:56:30 INFO - mkdir: /builds/slave/test/properties 03:56:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:56:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:56:30 INFO - Contents: 03:56:30 INFO - build_url:https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 03:56:31 INFO - Running post-action listener: _resource_record_post_action 03:56:31 INFO - Running post-action listener: set_extra_try_arguments 03:56:31 INFO - ##### 03:56:31 INFO - ##### Running populate-webroot step. 03:56:31 INFO - ##### 03:56:31 INFO - Running pre-action listener: _resource_record_pre_action 03:56:31 INFO - Running main action method: populate_webroot 03:56:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:56:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:56:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:56:31 INFO - '--tppagecycles', 03:56:31 INFO - '7'], 03:56:31 INFO - 'tests': ['tsvgm']}}, 03:56:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:56:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:56:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:56:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:56:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'tests': ['damp', 'tps']}, 03:56:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['damp', 'tps']}, 03:56:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:56:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:56:31 INFO - 'other': {'tests': ['a11yr', 03:56:31 INFO - 'ts_paint', 03:56:31 INFO - 'tpaint', 03:56:31 INFO - 'sessionrestore', 03:56:31 INFO - 'sessionrestore_no_auto_restore', 03:56:31 INFO - 'tabpaint']}, 03:56:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['a11yr', 03:56:31 INFO - 'ts_paint', 03:56:31 INFO - 'tpaint', 03:56:31 INFO - 'sessionrestore', 03:56:31 INFO - 'sessionrestore_no_auto_restore', 03:56:31 INFO - 'tabpaint']}, 03:56:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['a11yr', 03:56:31 INFO - 'ts_paint', 03:56:31 INFO - 'tpaint', 03:56:31 INFO - 'sessionrestore', 03:56:31 INFO - 'sessionrestore_no_auto_restore', 03:56:31 INFO - 'tabpaint']}, 03:56:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['a11yr', 03:56:31 INFO - 'ts_paint', 03:56:31 INFO - 'tpaint', 03:56:31 INFO - 'sessionrestore', 03:56:31 INFO - 'sessionrestore_no_auto_restore', 03:56:31 INFO - 'tabpaint']}, 03:56:31 INFO - 'other_l64': {'tests': ['a11yr', 03:56:31 INFO - 'ts_paint', 03:56:31 INFO - 'tpaint', 03:56:31 INFO - 'sessionrestore', 03:56:31 INFO - 'sessionrestore_no_auto_restore', 03:56:31 INFO - 'tabpaint']}, 03:56:31 INFO - 'other_nol64': {'tests': ['a11yr', 03:56:31 INFO - 'ts_paint', 03:56:31 INFO - 'tpaint', 03:56:31 INFO - 'sessionrestore', 03:56:31 INFO - 'sessionrestore_no_auto_restore', 03:56:31 INFO - 'tabpaint']}, 03:56:31 INFO - 'svgr': {'tests': ['tsvgx', 03:56:31 INFO - 'tsvgr_opacity', 03:56:31 INFO - 'tart', 03:56:31 INFO - 'tscrollx', 03:56:31 INFO - 'cart']}, 03:56:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['tsvgx', 03:56:31 INFO - 'tsvgr_opacity', 03:56:31 INFO - 'tart', 03:56:31 INFO - 'tscrollx', 03:56:31 INFO - 'cart']}, 03:56:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'tests': ['tp5o']}, 03:56:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'talos_options': ['--e10s'], 03:56:31 INFO - 'tests': ['tp5o']}, 03:56:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'talos_options': ['--xperf_path', 03:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:31 INFO - 'tests': ['tp5n']}, 03:56:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:56:31 INFO - 'talos_options': ['--e10s', 03:56:31 INFO - '--xperf_path', 03:56:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:31 INFO - 'tests': ['tp5n']}}, 03:56:31 INFO - 'talos.zip': {'path': '', 03:56:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:56:31 INFO - Running post-action listener: _resource_record_post_action 03:56:31 INFO - ##### 03:56:31 INFO - ##### Running create-virtualenv step. 03:56:31 INFO - ##### 03:56:31 INFO - Running pre-action listener: _resource_record_pre_action 03:56:31 INFO - Running main action method: create_virtualenv 03:56:31 INFO - Creating virtualenv /builds/slave/test/build/venv 03:56:31 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 03:56:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:56:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:56:31 INFO - Using real prefix '/usr' 03:56:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:56:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:56:34 INFO - Installing pip.................done. 03:56:34 INFO - Return code: 0 03:56:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:56:34 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')]} 03:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:34 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')]} 03:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:34 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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:34 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 03:56:34 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 03:56:34 INFO - Using env: {'DISPLAY': ':0', 03:56:34 INFO - 'HOME': '/home/cltbld', 03:56:34 INFO - 'LANG': 'en_US.UTF-8', 03:56:34 INFO - 'LANGUAGE': 'en_US:en', 03:56:34 INFO - 'LOGNAME': 'cltbld', 03:56:34 INFO - 'MAIL': '/var/mail/cltbld', 03:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:34 INFO - 'MOZ_NO_REMOTE': '1', 03:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:34 INFO - 'NO_EM_RESTART': '1', 03:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:34 INFO - 'PWD': '/builds/slave/test', 03:56:34 INFO - 'SHELL': '/bin/bash', 03:56:34 INFO - 'SHLVL': '1', 03:56:34 INFO - 'TERM': 'linux', 03:56:34 INFO - 'TMOUT': '86400', 03:56:34 INFO - 'USER': 'cltbld', 03:56:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:34 INFO - '_': '/tools/buildbot/bin/python'} 03:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:34 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 03:56:34 INFO - Cleaning up... 03:56:34 INFO - Return code: 0 03:56:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:56:34 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')]} 03:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:34 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')]} 03:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:34 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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:34 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 03:56:34 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 03:56:34 INFO - Using env: {'DISPLAY': ':0', 03:56:34 INFO - 'HOME': '/home/cltbld', 03:56:34 INFO - 'LANG': 'en_US.UTF-8', 03:56:34 INFO - 'LANGUAGE': 'en_US:en', 03:56:34 INFO - 'LOGNAME': 'cltbld', 03:56:34 INFO - 'MAIL': '/var/mail/cltbld', 03:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:34 INFO - 'MOZ_NO_REMOTE': '1', 03:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:34 INFO - 'NO_EM_RESTART': '1', 03:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:34 INFO - 'PWD': '/builds/slave/test', 03:56:34 INFO - 'SHELL': '/bin/bash', 03:56:34 INFO - 'SHLVL': '1', 03:56:34 INFO - 'TERM': 'linux', 03:56:34 INFO - 'TMOUT': '86400', 03:56:34 INFO - 'USER': 'cltbld', 03:56:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:34 INFO - '_': '/tools/buildbot/bin/python'} 03:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:34 INFO - Downloading/unpacking psutil>=0.7.1 03:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:36 INFO - Installing collected packages: psutil 03:56:36 INFO - Running setup.py install for psutil 03:56:36 INFO - building 'psutil._psutil_linux' extension 03:56:36 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 03:56:36 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 03:56:36 INFO - building 'psutil._psutil_posix' extension 03:56:36 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 03:56:36 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 03:56:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:37 INFO - Successfully installed psutil 03:56:37 INFO - Cleaning up... 03:56:37 INFO - Return code: 0 03:56:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:56:37 INFO - Using env: {'DISPLAY': ':0', 03:56:37 INFO - 'HOME': '/home/cltbld', 03:56:37 INFO - 'LANG': 'en_US.UTF-8', 03:56:37 INFO - 'LANGUAGE': 'en_US:en', 03:56:37 INFO - 'LOGNAME': 'cltbld', 03:56:37 INFO - 'MAIL': '/var/mail/cltbld', 03:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:37 INFO - 'MOZ_NO_REMOTE': '1', 03:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:37 INFO - 'NO_EM_RESTART': '1', 03:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:37 INFO - 'PWD': '/builds/slave/test', 03:56:37 INFO - 'SHELL': '/bin/bash', 03:56:37 INFO - 'SHLVL': '1', 03:56:37 INFO - 'TERM': 'linux', 03:56:37 INFO - 'TMOUT': '86400', 03:56:37 INFO - 'USER': 'cltbld', 03:56:37 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:37 INFO - '_': '/tools/buildbot/bin/python'} 03:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:56:39 INFO - Installing collected packages: mozsystemmonitor 03:56:39 INFO - Running setup.py install for mozsystemmonitor 03:56:39 INFO - Successfully installed mozsystemmonitor 03:56:39 INFO - Cleaning up... 03:56:39 INFO - Return code: 0 03:56:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:56: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')]} 03:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:39 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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:39 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 03:56:39 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 03:56:39 INFO - Using env: {'DISPLAY': ':0', 03:56:39 INFO - 'HOME': '/home/cltbld', 03:56:39 INFO - 'LANG': 'en_US.UTF-8', 03:56:39 INFO - 'LANGUAGE': 'en_US:en', 03:56:39 INFO - 'LOGNAME': 'cltbld', 03:56:39 INFO - 'MAIL': '/var/mail/cltbld', 03:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:39 INFO - 'MOZ_NO_REMOTE': '1', 03:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:39 INFO - 'NO_EM_RESTART': '1', 03:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:39 INFO - 'PWD': '/builds/slave/test', 03:56:39 INFO - 'SHELL': '/bin/bash', 03:56:39 INFO - 'SHLVL': '1', 03:56:39 INFO - 'TERM': 'linux', 03:56:39 INFO - 'TMOUT': '86400', 03:56:39 INFO - 'USER': 'cltbld', 03:56:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:39 INFO - '_': '/tools/buildbot/bin/python'} 03:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:56:39 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 03:56:39 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 03:56:39 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 03:56:39 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 03:56:39 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 03:56:39 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 03:56:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:56:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:56:41 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 03:56:41 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 03:56:41 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 03:56:41 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 03:56:41 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 03:56:41 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 03:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:56:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:56:41 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 03:56:41 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 03:56:41 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 03:56:41 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 03:56:41 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 03:56:41 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 03:56:42 INFO - Downloading docopt-0.6.1.tar.gz 03:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:56:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:56:42 INFO - Running setup.py install for blobuploader 03:56:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:56:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:56:42 INFO - Running setup.py install for requests 03:56:42 INFO - Running setup.py install for docopt 03:56:42 INFO - Successfully installed blobuploader requests docopt 03:56:42 INFO - Cleaning up... 03:56:42 INFO - Return code: 0 03:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56: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')]} 03:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:42 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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:42 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 03:56:42 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 03:56:42 INFO - Using env: {'DISPLAY': ':0', 03:56:42 INFO - 'HOME': '/home/cltbld', 03:56:42 INFO - 'LANG': 'en_US.UTF-8', 03:56:42 INFO - 'LANGUAGE': 'en_US:en', 03:56:42 INFO - 'LOGNAME': 'cltbld', 03:56:42 INFO - 'MAIL': '/var/mail/cltbld', 03:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:42 INFO - 'MOZ_NO_REMOTE': '1', 03:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:42 INFO - 'NO_EM_RESTART': '1', 03:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:42 INFO - 'PWD': '/builds/slave/test', 03:56:42 INFO - 'SHELL': '/bin/bash', 03:56:42 INFO - 'SHLVL': '1', 03:56:42 INFO - 'TERM': 'linux', 03:56:42 INFO - 'TMOUT': '86400', 03:56:42 INFO - 'USER': 'cltbld', 03:56:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:42 INFO - '_': '/tools/buildbot/bin/python'} 03:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:42 INFO - Running setup.py (path:/tmp/pip-CcOZaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:43 INFO - Running setup.py (path:/tmp/pip-65PWHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:43 INFO - Running setup.py (path:/tmp/pip-Bt0te4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:43 INFO - Running setup.py (path:/tmp/pip-Aj4R_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:43 INFO - Running setup.py (path:/tmp/pip-LBcZeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:43 INFO - Running setup.py (path:/tmp/pip-d7IZuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:43 INFO - Running setup.py (path:/tmp/pip-yES014-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:43 INFO - Running setup.py (path:/tmp/pip-p2Y7HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:43 INFO - Running setup.py (path:/tmp/pip-kbwI8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:43 INFO - Running setup.py (path:/tmp/pip-UOJGZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:43 INFO - Running setup.py (path:/tmp/pip-mey40a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:43 INFO - Running setup.py (path:/tmp/pip-nLFuSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:43 INFO - Running setup.py (path:/tmp/pip-Gj1vvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:43 INFO - Running setup.py (path:/tmp/pip-eQTUvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:44 INFO - Running setup.py (path:/tmp/pip-E_sIEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:44 INFO - Running setup.py (path:/tmp/pip-3wvQWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:44 INFO - Running setup.py (path:/tmp/pip-_Zj1zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:56:44 INFO - Running setup.py install for manifestparser 03:56:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:56:44 INFO - Running setup.py install for mozcrash 03:56:44 INFO - Running setup.py install for mozdebug 03:56:44 INFO - Running setup.py install for mozdevice 03:56:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:56:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:56:44 INFO - Running setup.py install for mozfile 03:56:44 INFO - Running setup.py install for mozhttpd 03:56:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:56:44 INFO - Running setup.py install for mozinfo 03:56:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:56:44 INFO - Running setup.py install for mozInstall 03:56:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Running setup.py install for mozleak 03:56:45 INFO - Running setup.py install for mozlog 03:56:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Running setup.py install for moznetwork 03:56:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Running setup.py install for mozprocess 03:56:45 INFO - Running setup.py install for mozprofile 03:56:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Running setup.py install for mozrunner 03:56:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Running setup.py install for mozscreenshot 03:56:45 INFO - Running setup.py install for moztest 03:56:45 INFO - Running setup.py install for mozversion 03:56:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:56:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:56:45 INFO - Cleaning up... 03:56:45 INFO - Return code: 0 03:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56:45 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')]} 03:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:46 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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:46 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 03:56:46 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 03:56:46 INFO - Using env: {'DISPLAY': ':0', 03:56:46 INFO - 'HOME': '/home/cltbld', 03:56:46 INFO - 'LANG': 'en_US.UTF-8', 03:56:46 INFO - 'LANGUAGE': 'en_US:en', 03:56:46 INFO - 'LOGNAME': 'cltbld', 03:56:46 INFO - 'MAIL': '/var/mail/cltbld', 03:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:46 INFO - 'MOZ_NO_REMOTE': '1', 03:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:46 INFO - 'NO_EM_RESTART': '1', 03:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:46 INFO - 'PWD': '/builds/slave/test', 03:56:46 INFO - 'SHELL': '/bin/bash', 03:56:46 INFO - 'SHLVL': '1', 03:56:46 INFO - 'TERM': 'linux', 03:56:46 INFO - 'TMOUT': '86400', 03:56:46 INFO - 'USER': 'cltbld', 03:56:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:46 INFO - '_': '/tools/buildbot/bin/python'} 03:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:56:46 INFO - Running setup.py (path:/tmp/pip-XKRB7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:56:46 INFO - Running setup.py (path:/tmp/pip-F3OJqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:56:46 INFO - Running setup.py (path:/tmp/pip-Yto4st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:56:46 INFO - Running setup.py (path:/tmp/pip-53Pk7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:56:46 INFO - Running setup.py (path:/tmp/pip-kdARHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:56:46 INFO - Running setup.py (path:/tmp/pip-Wg5Zyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:56:46 INFO - Running setup.py (path:/tmp/pip-pC2fKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:56:46 INFO - Running setup.py (path:/tmp/pip-NEUizk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:56:46 INFO - Running setup.py (path:/tmp/pip-in0OfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:56:46 INFO - Running setup.py (path:/tmp/pip-VttU6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:56:46 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)) 03:56:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:56:46 INFO - Running setup.py (path:/tmp/pip-fpXfGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:56:47 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)) 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:56:47 INFO - Running setup.py (path:/tmp/pip-GcmMic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:56:47 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)) 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:56:47 INFO - Running setup.py (path:/tmp/pip-OwTTwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:56:47 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)) 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:56:47 INFO - Running setup.py (path:/tmp/pip-Ks4aWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:56:47 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)) 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:47 INFO - Running setup.py (path:/tmp/pip-C5btcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:56:47 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)) 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:56:47 INFO - Running setup.py (path:/tmp/pip-m55Jnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:56:47 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)) 03:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:56:47 INFO - Running setup.py (path:/tmp/pip-Jn5rFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:56:47 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)) 03:56:47 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)) 03:56:47 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)) 03:56:47 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)) 03:56:47 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)) 03:56:47 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)) 03:56:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:56:47 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 03:56:47 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 03:56:47 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 03:56:47 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 03:56:47 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 03:56:47 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 03:56:49 INFO - Downloading blessings-1.6.tar.gz 03:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:56:49 INFO - Installing collected packages: blessings 03:56:49 INFO - Running setup.py install for blessings 03:56:49 INFO - Successfully installed blessings 03:56:49 INFO - Cleaning up... 03:56:49 INFO - Return code: 0 03:56:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:49 INFO - Reading from file tmpfile_stdout 03:56:49 INFO - Current package versions: 03:56:49 INFO - argparse == 1.2.1 03:56:49 INFO - blessings == 1.6 03:56:49 INFO - blobuploader == 1.2.4 03:56:49 INFO - docopt == 0.6.1 03:56:49 INFO - manifestparser == 1.1 03:56:49 INFO - mozInstall == 1.12 03:56:49 INFO - mozcrash == 0.17 03:56:49 INFO - mozdebug == 0.1 03:56:49 INFO - mozdevice == 0.48 03:56:49 INFO - mozfile == 1.2 03:56:49 INFO - mozhttpd == 0.7 03:56:49 INFO - mozinfo == 0.9 03:56:49 INFO - mozleak == 0.1 03:56:49 INFO - mozlog == 3.1 03:56:49 INFO - moznetwork == 0.27 03:56:49 INFO - mozprocess == 0.22 03:56:49 INFO - mozprofile == 0.28 03:56:49 INFO - mozrunner == 6.11 03:56:49 INFO - mozscreenshot == 0.1 03:56:49 INFO - mozsystemmonitor == 0.0 03:56:49 INFO - moztest == 0.7 03:56:49 INFO - mozversion == 1.4 03:56:49 INFO - psutil == 3.1.1 03:56:49 INFO - requests == 1.2.3 03:56:49 INFO - wsgiref == 0.1.2 03:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:56: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')]} 03:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:49 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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:49 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 03:56:49 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 03:56:49 INFO - Using env: {'DISPLAY': ':0', 03:56:49 INFO - 'HOME': '/home/cltbld', 03:56:49 INFO - 'LANG': 'en_US.UTF-8', 03:56:49 INFO - 'LANGUAGE': 'en_US:en', 03:56:49 INFO - 'LOGNAME': 'cltbld', 03:56:49 INFO - 'MAIL': '/var/mail/cltbld', 03:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:49 INFO - 'MOZ_NO_REMOTE': '1', 03:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:49 INFO - 'NO_EM_RESTART': '1', 03:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:49 INFO - 'PWD': '/builds/slave/test', 03:56:49 INFO - 'SHELL': '/bin/bash', 03:56:49 INFO - 'SHLVL': '1', 03:56:49 INFO - 'TERM': 'linux', 03:56:49 INFO - 'TMOUT': '86400', 03:56:49 INFO - 'USER': 'cltbld', 03:56:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:49 INFO - '_': '/tools/buildbot/bin/python'} 03:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 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)) 03:56:49 INFO - Cleaning up... 03:56:49 INFO - Return code: 0 03:56:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:56: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')]} 03:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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')]} 03:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56: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', 'jsonschema'] in /builds/slave/test/build 03:56: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 jsonschema 03:56:49 INFO - Using env: {'DISPLAY': ':0', 03:56:49 INFO - 'HOME': '/home/cltbld', 03:56:49 INFO - 'LANG': 'en_US.UTF-8', 03:56:49 INFO - 'LANGUAGE': 'en_US:en', 03:56:49 INFO - 'LOGNAME': 'cltbld', 03:56:49 INFO - 'MAIL': '/var/mail/cltbld', 03:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:49 INFO - 'MOZ_NO_REMOTE': '1', 03:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:49 INFO - 'NO_EM_RESTART': '1', 03:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:49 INFO - 'PWD': '/builds/slave/test', 03:56:49 INFO - 'SHELL': '/bin/bash', 03:56:49 INFO - 'SHLVL': '1', 03:56:49 INFO - 'TERM': 'linux', 03:56:49 INFO - 'TMOUT': '86400', 03:56:49 INFO - 'USER': 'cltbld', 03:56:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:49 INFO - '_': '/tools/buildbot/bin/python'} 03:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:50 INFO - Downloading/unpacking jsonschema 03:56:50 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 03:56:50 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 03:56:50 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 03:56:50 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 03:56:50 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 03:56:50 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 03:56:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:56:51 INFO - Downloading/unpacking functools32 (from jsonschema) 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56: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 03:56:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:56:52 INFO - warning: no files found matching '*.txt' 03:56:52 INFO - no previously-included directories found matching 'build' 03:56:52 INFO - no previously-included directories found matching 'dist' 03:56:52 INFO - no previously-included directories found matching '.git*' 03:56:52 INFO - Installing collected packages: jsonschema, functools32 03:56:52 INFO - Running setup.py install for functools32 03:56:52 INFO - warning: no files found matching '*.txt' 03:56:52 INFO - no previously-included directories found matching 'build' 03:56:52 INFO - no previously-included directories found matching 'dist' 03:56:52 INFO - no previously-included directories found matching '.git*' 03:56:52 INFO - Successfully installed jsonschema functools32 03:56:52 INFO - Cleaning up... 03:56:52 INFO - Return code: 0 03:56:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:56:52 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 0x7f07a1b56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bd4410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', '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 03:56:52 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 03:56:52 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 03:56:52 INFO - Using env: {'DISPLAY': ':0', 03:56:52 INFO - 'HOME': '/home/cltbld', 03:56:52 INFO - 'LANG': 'en_US.UTF-8', 03:56:52 INFO - 'LANGUAGE': 'en_US:en', 03:56:52 INFO - 'LOGNAME': 'cltbld', 03:56:52 INFO - 'MAIL': '/var/mail/cltbld', 03:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:52 INFO - 'MOZ_NO_REMOTE': '1', 03:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:52 INFO - 'NO_EM_RESTART': '1', 03:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:52 INFO - 'PWD': '/builds/slave/test', 03:56:52 INFO - 'SHELL': '/bin/bash', 03:56:52 INFO - 'SHLVL': '1', 03:56:52 INFO - 'TERM': 'linux', 03:56:52 INFO - 'TMOUT': '86400', 03:56:52 INFO - 'USER': 'cltbld', 03:56:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:52 INFO - '_': '/tools/buildbot/bin/python'} 03:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:52 INFO - Downloading/unpacking flake8 03:56:52 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 03:56:52 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 03:56:52 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 03:56:52 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 03:56:52 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 03:56:52 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 03:56:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:56:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:56:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:54 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 03:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:55 INFO - no previously-included directories found matching 'docs/_build' 03:56:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:56:55 INFO - Running setup.py install for pep8 03:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:56:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:56:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:56:55 INFO - no previously-included directories found matching 'docs/_build' 03:56:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:56:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:56:55 INFO - Cleaning up... 03:56:55 INFO - Return code: 0 03:56:55 INFO - Running post-action listener: _resource_record_post_action 03:56:55 INFO - Running post-action listener: _start_resource_monitoring 03:56:55 INFO - Starting resource monitoring. 03:56:55 INFO - ##### 03:56:55 INFO - ##### Running install step. 03:56:55 INFO - ##### 03:56:55 INFO - Running pre-action listener: _resource_record_pre_action 03:56:55 INFO - Running main action method: install 03:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:56:55 INFO - Reading from file tmpfile_stdout 03:56:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:56:55 INFO - Reading from file tmpfile_stdout 03:56:55 INFO - Output received: 03:56:55 INFO - Usage: mozinstall [options] installer 03:56:55 INFO - Options: 03:56:55 INFO - -h, --help show this help message and exit 03:56:55 INFO - -d DEST, --destination=DEST 03:56:55 INFO - Directory to install application into. [default: 03:56:55 INFO - "/builds/slave/test"] 03:56:55 INFO - --app=APP Application being installed. [default: firefox] 03:56:55 INFO - mkdir: /builds/slave/test/build/application 03:56:55 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'] 03:56:55 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 03:57:11 INFO - Reading from file tmpfile_stdout 03:57:11 INFO - Output received: 03:57:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:11 INFO - Running post-action listener: _resource_record_post_action 03:57:11 INFO - ##### 03:57:11 INFO - ##### Running run-tests step. 03:57:11 INFO - ##### 03:57:11 INFO - Running pre-action listener: _resource_record_pre_action 03:57:11 INFO - Running main action method: run_tests 03:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:11 INFO - Python 2.7.3 03:57:11 INFO - Return code: 0 03:57:11 INFO - grabbing minidump binary from tooltool 03:57:11 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')]} 03:57:11 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 0x1c63160>, '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 0x1c64060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c644f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:11 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 03:57:11 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 03:57:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:11 INFO - Return code: 0 03:57:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:57:12 INFO - Return code: 0 03:57:12 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/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 03:57:12 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/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 03:57:12 INFO - Using env: {'DISPLAY': ':0', 03:57:12 INFO - 'HOME': '/home/cltbld', 03:57:12 INFO - 'LANG': 'en_US.UTF-8', 03:57:12 INFO - 'LANGUAGE': 'en_US:en', 03:57:12 INFO - 'LOGNAME': 'cltbld', 03:57:12 INFO - 'MAIL': '/var/mail/cltbld', 03:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:12 INFO - 'MOZ_NO_REMOTE': '1', 03:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:12 INFO - 'NO_EM_RESTART': '1', 03:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:12 INFO - 'PWD': '/builds/slave/test', 03:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:12 INFO - 'SHELL': '/bin/bash', 03:57:12 INFO - 'SHLVL': '1', 03:57:12 INFO - 'TERM': 'linux', 03:57:12 INFO - 'TMOUT': '86400', 03:57:12 INFO - 'USER': 'cltbld', 03:57:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832', 03:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:12 INFO - '_': '/tools/buildbot/bin/python'} 03:57:12 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/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 03:57:12 INFO - mozversion application_buildid: 20160311031816 03:57:12 INFO - mozversion application_changeset: f7ed458ec73dc42d58fda3d69b1036738d968833 03:57:12 INFO - mozversion application_display_name: Nightly 03:57:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:12 INFO - mozversion application_name: Firefox 03:57:12 INFO - mozversion application_remotingname: firefox 03:57:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:57:12 INFO - mozversion application_vendor: Mozilla 03:57:12 INFO - mozversion application_version: 48.0a1 03:57:12 INFO - mozversion platform_buildid: 20160311031816 03:57:12 INFO - mozversion platform_changeset: f7ed458ec73dc42d58fda3d69b1036738d968833 03:57:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:57:12 INFO - mozversion platform_version: 48.0a1 03:57:12 INFO - using testdate: 1457697432 03:57:12 INFO - actual date: 1457697432 03:57:12 INFO - starting webserver on 'localhost:41419' 03:57:12 INFO - SUITE-START | Running 2 tests 03:57:12 INFO - TEST-START | dromaeo_css 03:57:12 INFO - operating with platform_type : linux_ 03:57:12 INFO - Initialising browser for dromaeo_css test... 03:57:12 INFO - TEST-INFO | started process 4468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhzL6C/profile http://localhost:41419/getInfo.html) 03:57:17 INFO - PROCESS | 4468 | __metrics Screen width/height:1600/1200 03:57:17 INFO - PROCESS | 4468 | colorDepth:24 03:57:17 INFO - PROCESS | 4468 | Browser inner width/height: 1024/697 03:57:17 INFO - PROCESS | 4468 | __metrics 03:57:18 ERROR - PROCESS | 4468 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:57:19 INFO - TEST-INFO | 4468: exit 0 03:57:19 INFO - Browser initialized. 03:57:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:57:19 INFO - TEST-INFO | started process 4561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhzL6C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:31 INFO - PROCESS | 4561 | RSS: Main: 153313280 03:57:31 INFO - PROCESS | 4561 | 03:58:22 INFO - PROCESS | 4561 | 1457697502535 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:00:33 INFO - PROCESS | 4561 | Cycle 1(1): loaded http://localhost:41419/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41419/tests/dromaeo/cssquery-ext.html) 04:00:34 INFO - PROCESS | 4561 | RSS: Main: 242364416 04:00:34 INFO - PROCESS | 4561 | 04:03:36 INFO - PROCESS | 4561 | Cycle 1(1): loaded http://localhost:41419/tests/dromaeo/cssquery-ext.html (next: http://localhost:41419/tests/dromaeo/cssquery-jquery.html) 04:03:37 INFO - PROCESS | 4561 | RSS: Main: 240676864 04:03:37 INFO - PROCESS | 4561 | 04:06:39 INFO - PROCESS | 4561 | Cycle 1(1): loaded http://localhost:41419/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41419/tests/dromaeo/cssquery-mootools.html) 04:06:40 INFO - PROCESS | 4561 | RSS: Main: 229060608 04:06:40 INFO - PROCESS | 4561 | 04:09:42 INFO - PROCESS | 4561 | Cycle 1(1): loaded http://localhost:41419/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41419/tests/dromaeo/cssquery-prototype.html) 04:09:42 INFO - PROCESS | 4561 | RSS: Main: 212910080 04:09:42 INFO - PROCESS | 4561 | 04:12:45 INFO - PROCESS | 4561 | Cycle 1(1): loaded http://localhost:41419/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41419/tests/dromaeo/cssquery-yui.html) 04:12:46 INFO - PROCESS | 4561 | RSS: Main: 189808640 04:12:46 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | Cycle 1(1): loaded http://localhost:41419/tests/dromaeo/cssquery-yui.html (next: http://localhost:41419/tests/dromaeo/cssquery-dojo.html) 04:15:48 INFO - PROCESS | 4561 | RSS: Main: 262250496 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | __start_tp_report 04:15:48 INFO - PROCESS | 4561 | _x_x_mozilla_page_load 04:15:48 INFO - PROCESS | 4561 | _x_x_mozilla_page_load_details 04:15:48 INFO - PROCESS | 4561 | |i|pagename|runs| 04:15:48 INFO - PROCESS | 4561 | |0;dojo.html;2580.6774153230845;2589.4691588224414;2618.3977685132413;2619.7249288824673;2634.2492389668937;4405.867823965278;4492.079123779626;4523.909521809566;4527.808548646245;4545.954540454594;4487.977560112203;4513.842015529457;4545.681802273843;4547.113312903985;4604.608608268301;4135.586441355856;4148.315527937887;4150;4183.0797224610615;4264.42430271914;4181.686373521983;4200.327947528381;4232.111256636094;4261.403403523509;4268.487781466229;4047.170330082326;4114.506259248879;4165.187788381267;4213.936790948138;4221.345691417835;4155.252054630166;4183.769892655902;4187.476565429321;4223.176480586287;4229.069604686964;4044.716869819114;4165.645920096796;4177.97911010443;4191.497020357577;4227.8097485613225;4395.274779661352;4429.667774916894;4475.77621118946;4482.574155455227;4518.841840535565;4793.32893394925;4815.470298267188;4838.201696720037;4845.927311090337;4873.8781530461665;4663.347131401607;4768.284757286435;4861.416630004422;4862.270659401118;4895.485973972717;4467.910641787211;4472.776361181928;4502.549745025504;4505.617022553054;4514.683972121953;4893;4908;4910.116179087799;4911.9754401227765;4947.282644016597;4599.40207772994;4678.087772884255;4716.764161791897;4721.504242054603;4744.051189762062;4803.255495398219;4818.036392721469;4822.517748225219;4849.709017458893;4862.513748625109;4778.952210477851;4782.832600858953;4783.019481006385;4787.0904528139545;4826.938073623797;4583.152116858392;4720.858374248778;4749.453812811502;4820.204666230103;4820.276958456259;4031.4355990161403;4035.0921042765144;4036.737612055207;4039;4060.1067765091634;3571.464280357915;3571.8571257149424;3601.7658852174527;3604.7837129772297;3611.837467313977;4074.4499492568716;4149.294619914562;4152.356384760367;4239.894002649959;4248.044190057212;4785.377900872933;4805.3512775775525;4823.975880120647;4824.204006338915;4866.270059491034;4165.770882601425;4170.603792639695;4172.415861779354;4173.582641735863;4208.684348673862;4149.128682976609;4245.490541135084;4297.527272000078;4313.245182093184;4339.067100573392;4573.794179261875;4574.08518296342;4591.931121033121;4592.540745925515;4626.074785043005;4691.225947718588;4851.854444366674;4863.513648635108;4867.561919427269;4900.975495122501;4535.206338890615;4591.816327347003;4594.448666160082;4623.630109591292;4637.582617564435;4703.811847526061;4715.504871988392;4715.622750180046;4716.1510928033285;4736.8578942631775;4596.5863072323655;4718.221493453541;4757.452892917358;4765.0946320199055;4807.302941073455;4611.077784443192;4622.791974361095;4627.7686115693405;4657.534246575316;4674.953250467452;4638.721676699409;4641.883952901205;4647.093816705845;4681.882952926204;4681.882952926204;4389.385486032022;4543.091381723734;4552.704074235164;4562.58936695699;4652.581267685924;4708.411448568929;4726.480087190475;4743.857684269477;4764.023375208143;4790.01804630057;4569.885752856205;4576.222042252892;4578.5421457853945;4606.078784243098;4627.167109920112 04:15:48 INFO - PROCESS | 4561 | |1;ext.html;490.9067277217331;493.2034763856371;512.2495544028;548.0491347512067;555.2199160179946;23420.297391078275;23963.52072958542;23982.76017239827;24017.159399421;33512.664873351256;36577.45133822995;37003.62996370042;37017.81491092541;37127.257454850886;37155.25689486209;7515.2860478254615;7759.913612094311;7764.572948487831;7765.223477652218;7767.300942915136;7681.193474685161;7821.843563128734;7824.452288339819;7826.921730782677;7831.921680783176;7794.766157015299;7873.606319684021;7878.054633443995;7890.0531936167745;8101.716439924604;7927.682892684285;8014.599270036504;8016.63925123368;8016.799580010488;8021.799455013671;7778.6499607517235;7906.288434040906;7908.9604551977445;7909.446338756289;7913.287804097601;36847.815760921294;37500;37503.62496375056;37550;37662.81168594139;2787.2753084198052;2838.6451693538306;2894.2474956511246;2923.4153169366214;3069.3554353585773;28288.71711282902;28300.575491367646;28572.571411428846;29146.125616231548;29205.561916571267;3404.975966926516;3465.7747246428903;3488.773229740059;3547.343741407848;3575.410057340536;214526;215461;215510;216622;216844;38553.2289354217;53269;53742.73128634332;53827.46172538303;53852.46147538474;36433.27133457316;36546.08634784152;36552.81723591418;36653.63346366555;36737.26525469476;13179.60461186166;13368.598942031755;13375.063745537913;13381.397837097355;13386.866131338757;10593;10628.36229826213;10635.627753028606;10638.255322127532;10639.25525213243;13308.933455332855;13347.532836350681;13438.596842094752;13474.19154850712;13551.25468099264;5351.732413379315;5579.665220086727;5579.972100139474;5582.888342233133;5583.553315734732;819.6557445872628;832.4422636833336;867.492516877621;886.3883920095113;904.7602385367883;26001.219963401127;26614.866925665636;26770;26942;26977.325566860985;915.3272344826547;926.7405126564573;987.6641941739842;999.9250805384241;1082.7022568793486;12774.425150868234;13095.738085238241;13111;13278.136921100098;13298.468061277441;252693;253162.73418633157;256218;256237;256467;46099;46757.29864052042;46873.29690054652;46889;46925.29612055822;1037.1650821088945;1130.496928866663;1153.0890596428894;1162.151629310591;1201.4893670190133;23865.164719234745;24208;24693.753062469146;24899;24957.251282461555;33249.50125748164;33279;33569.328613428086;33597.49603755995;33649;138826;140247;140393;140413.2979335097;140433;24073.879630601736;27978.58032129479;28766.424671506873;28771.424571508873;28913.277168070126;33730.662693373735;41699;42181;42787.57212427836;43089.56910430981;30039.84980075173;30577;30672.84663576757;30734.846325768227;30909.69090309158;32632.83683581567;33258.50112248366;33293.00604909283;33433;33827.32345353128;32858.50712239366;33434.16414589557;33534.329313414084;33643;33654;28483.430331392843;28815.37246433374;29967.4006519864;30346.241343965696;30390.392192155592;23907.521849563258;24047.639285410383;24072.87963560171;24213.273601791974;24299 04:15:48 INFO - PROCESS | 4561 | |2;jquery.html;332.1762030165192;332.57762641445373;335.8404757740073;337.37922223109473;337.71125687537153;14289.499867504626;15190.924045379772;15690.52928412148;16306.429274975379;16386.26261818218;11771.941140294286;12157.57448489303;13635.522756703518;14129.222892740896;15347;4782.928256076161;4830.903381932368;5003.374578177728;5020.447750747433;5035.84892453227;4919.212925931852;4947.233178857283;4949.059678661061;4977.129002424579;4980.900381992358;3493.510908472816;4830.082284365977;5488.725563721818;5703.3441154267375;5703.458171473703;5642.069058605325;5652.830415087513;5652.858678533049;5673.744681489343;5674.829755107354;4809.206480930678;4922.680025798348;4958;4999.225120106389;4999.400071991385;17627.471175864746;17677.20452579624;17686.91156544222;17956.371526996623;18934.810651893582;1757.3497805811803;1791.6954117800005;1808.2495764257949;1821.9908900455546;1857.544901499128;11876.52493900243;12217.755644887142;12362.938185309016;12590.74818503634;12773.105882588223;1706.7781188445547;1793.7757780277466;1817.0914542728635;1836.2838492987746;1842.7604411426428;56169.43830561724;57633;58975.11537326901;59195;59672.70163649198;8652.697155599524;9193.586288617029;9357.707361696428;9397.765055873659;9407.90592094084;11610.535578576932;11717.238379505305;11745.29528228292;11808.46861891217;11811.704707382212;6076.088586712029;6933.583984960918;7137.429005679637;7176.820579485555;7186.029885965432;6476.740930362733;6789.456843452611;6797.388235058868;6820.249772525019;6905.620190889449;5313.681179129265;5381.219723140122;5399.325084364455;5406.91889621656;5474.808381706621;1636.2882146266413;1640.5816516788143;1659.7676325314465;1668.5077902018934;1673.0714453478192;820.1306614988132;853.3599800149888;873.4191762478008;884.8893888263967;891.0154279521165;14984;15169.165695886612;15450.845491545166;15558.766618500731;15731.528054158394;843.9071702112763;855.2901092093548;855.3285670748432;871.7254064969515;907.2877790934217;8904.50734845217;8989.190972812348;9130.81738365229;9182.357234993486;9407.764805879908;335763;340793;344526;345721;346131;70821.64589177124;71315.64342178359;72063;74699.25300746923;75497.6225118871;863.5293764898146;864.304235090758;888.8844450221429;893.0801274687083;897.0312062971975;13828.446862125402;13971.860281397463;14152.43390264378;14434.855651443351;14447.277636117942;30885.536716948813;31136.532952005284;32244.19389515281;32979;33076.83461582773;35129.64870351366;35406.64593354137;43042.56957430386;46135.76932115318;46799;6870.484713646397;6891.241963383924;7027.824304392431;7069.823254418475;7075.540089894141;9446.38598491096;10476.68569942903;10707.571697132027;10885.129189664649;11036.779264414827;8952.28381729447;8954.910450895408;9258.722238332592;9318.254539636677;9352.953235233781;4750.667453278375;7965.522068675898;9029.954850225708;9230.169284764135;9706;9942.900570994487;9966;10087;10234.692959211236;10249.128824049742;6984.21902414881;7230.710771569078;7301.890471642823;7377.3360397564475;7414.962925185339;8484.915150848412;9510.904890951279;9589.232861370934;9738.853917191105;9777.266704997011 04:15:48 INFO - PROCESS | 4561 | |3;mootools.html;1250.6373151785983;1385.0581604508934;1387.8334599848017;1505.5709122899968;1738.7913450385956;6931.133608298963;7073.717051317941;7087.4684398670115;7093.574385536871;7097.396721278697;7186;7325.340719335259;7338.229485903983;7344.889826652605;7345.632718364087;2018.9293374731888;2116.43914362694;2117.3436234767196;2117.375374264588;2118.8093071623553;2139.497218153733;2176.2491940280656;2181.770914054025;2182.0726191368603;2186.2348178137604;2134.978650213501;2137.3267420762486;2159.7948194921455;2162.9783702162936;2164.4047886831167;2169.2624507667388;2195.9121635134575;2196.406970118067;2196.8681879087226;2197.967030494544;2147.4738689021133;2189.0477642225683;2190.8466407351493;2192.0683709423433;2192.7039849620255;7457.701691932316;7510;7511.774646760606;7537.698492060365;7544.245575442466;4246.851360202409;4295.978520107411;4351.369051487548;4358.498772641124;4389.648828093745;2724.7956403269836;2793.5111355512704;2818.9436211275865;2838.2762395589198;2841.6163817884526;855.7817756472122;871.3856731004627;882.9028806831243;888.1251966812684;898.1198425542939;10000.299979001473;10181.79636407275;10191.184705223564;10197;10221.591136354537;3898.434726964574;4012.578679238638;4020.8190631421658;4095.795210239476;4096.5903409659395;8742.388032837767;8789.912100879037;8832.911670883337;8847.955760221286;8849.51327676971;4293.656507479394;4307.138572285556;4314.741115533078;4318.5681431856565;4325.891852703645;3394.6096198936943;3690.464882592009;3807.2385522895534;3864.5555761087835;3867.9806600966817;3392.406328892434;3444.844981975817;3473.600535938349;3484.0244731475227;3500.5274287971306;1083.149727463937;1087.2009073331253;1090.1358676662994;1092.0280949954547;1100.834874768791;819.6721311475338;832.3632421197789;838.8364268967492;844.8986121665439;1106.8727096384018;6569.408753212234;6729.192496900403;6729.8654026919185;6730.259671436138;6744.6627668616375;562.016471175443;567.6537312239531;568.9260396148557;583.1893667801759;722.0937723157404;5194.402643696023;5202.84391468249;5206.947930520722;5207.661502002357;5237.371515418098;8338.37462190326;8988;9020.323475739346;9302.16280534755;9312.441253524674;9067.18395344409;9090.909090909006;9124.954375228213;9130.31522635805;9133.68032118886;6550.6069635822005;6766.594004359853;6786.423154031864;6792.626405547742;7053.964730176316;6838.04267402574;6890.724371025103;6904.03343531916;6905.792826215222;6912.377885990285;7802.29779319864;8092.595370231583;8102.513849169069;8107.797305067184;8240.423170378015;7627.389808815171;7895.1315355309725;7905.32804711606;8023.1976802319305;8025.8394832104195;6010.248718910137;6044.758209671564;6082.847928801815;6108.389161083856;6117.785877494266;6888.276730943179;6894.620795856276;6894.8621027580175;6915.135608048994;6942.375186233263;5943.138244954544;6213.068039793886;6222.875542489034;6285.654289014148;6306.432421082125;5344.171653393731;5547.944520554743;5874.324452687995;6039.456448919618;6056.878862422815;6281.246250449975;6298.622082675054;6338.366163383625;6343.9365606343345;6378.1070650108095;5737.053386191232;5772.422757724194;5804.303483581997;5831.387704290988;5831.446012628793;5909.497692696169;5949.494292984971;5953.374895635896;6071;6144.907826382697 04:15:48 INFO - PROCESS | 4561 | |4;prototype.html;281.36411709536446;284.94443583501214;293.5464707027642;305.68209062574925;306.789848953467;5140.640155189134;5145.202493613491;5152.562032227256;5176.1200595898745;5195.428502864682;5144.485551444854;5147.51098645629;5148.922766158511;5163.7418129093585;5163.974180129094;3837.788921609317;3881.786501742403;3952.466417033707;3959.227950549644;3964.048628329195;4011.1576568920414;4018.1762738638654;4029.5970402959615;4035.4148648445957;4036.071703508195;3971.3645816669336;3973.8807835764974;3980.9203815923665;3985.5217373915025;3986.9800650996704;3818.16000479894;3875.2249550089814;3963.564007959122;3970.8014599269923;3972.880813575583;3463.5497385339995;3469.61834198238;3474.3398754236614;3475.131217195701;3479.3389256041523;4926.704397736112;4963.726995015273;4967.379077615298;4973.104841128596;4975.7263350515705;4562.745245057603;4566;4570.65720070996;4576.977115114437;4584.885377865547;5391.110466772978;5397;5397.163439666858;5402.459754024605;5405.5135037846785;3756.835381031889;3760.2479504099288;3763.3602287610897;3764.7176461765475;3783.9432408513894;5437.401885792559;5617.887642247173;5671.120976248688;5677.886442271131;5682.403347648478;3766.1902690921584;3781.0736369589076;3802.2585595809105;3803.201327721154;3806.3719486284454;3849.9807500962875;3856.6914646828186;3864.8260828262796;3894.337962546317;3895.7272990890365;4465.955340446554;4481.663875209372;4483.461984561808;4503.91905942578;4511.571400716926;5447.809326673548;5453.700046497402;5458.235846981426;5459.754311056012;5463.699496527729;1344.4554955243143;1370.9657258568416;1373.1898180073804;1373.8900887928942;1374.4639590559689;883.0507204754914;909.9363044586815;910.1035480052143;928.122923836981;932.0446542294068;4618.122556714214;4691.225947718588;4779.545943135397;4792.610143058544;4794.760261986887;5606.299212598426;5674.687892165888;5696.914546281809;5698.344690360579;5698.772049118072;4836.056968891103;4837.516248375205;4840.75796210188;4850.975745121252;4851.611871050308;3009.202561321252;3040.467918114321;3043.8630261638277;3046.466868298039;3047.67999360064;5372.597055220874;5372.704501252469;5380.569554435636;5382.569394448435;5384.0847056000575;5666.2350582670815;5830.62100963436;5845.269341332333;5845.707714614252;5846.970765146147;5344.251804747416;5360.731963401892;5374.462553744673;5376.4623537647485;5383.973080134574;5667.433256674464;5679.176519404746;5684.8294551163535;5690.630109042899;5691;5550.389457159628;5555.3611334697025;5572.721363931868;5583.330000399978;5596.468335508121;5358.142697168434;5361.812336568201;5366.812161574326;5369.27514785499;5378.085725426608;3702.167012422291;3853.3256680081436;3864.265789499986;3879.2047630236298;3880.185161116084;5540.833774986757;5557.221988921635;5569.693666848362;5573.27547418833;5577.191307260506;5330.387005494263;5355.78576856937;5369.140937450145;5374.704391258519;5388.676679399092;5387.86530336729;5395.298611180679;5405.5135037846785;5407.945450637088;5418.783248670166;5301.019311427398;5302.734863256745;5303.681779093266;5305.708186049805;5312.043832110257;5288.074586947192;5443.210734443404;5444.96545656324;5449.373322068013;5520.089185284543;5297.867553311198;5314.601404894725;5315.468453154654;5318.840434786963;5322.28149199853 04:15:48 INFO - PROCESS | 4561 | |5;yui.html;632.9588576742509;657.8585604095118;690.951633385663;735.5329365852683;748.5134662469396;11812.232204906686;12130.514779408835;12130.636080917575;12147.574834880781;12148.27110373377;11621.709457263572;11668.708282292946;11675.941620291887;11683.532658693663;11689.12331575133;619.4579742725116;773.7562667759652;793.0443815202696;811.3428123220181;814.0394334685069;800.9719659811908;804.9154838741906;807.3621838747382;807.3742849291787;807.4347956430493;834.8539005673982;838.7316058861167;839.1608391608391;839.3872473094644;839.6515446089866;646.0599827251338;654.077750371978;656.1568384625757;832.7626626411474;837.5937670229933;623.0716232813121;624.0389799708444;624.3600309682566;624.4567226512918;624.8250489862845;11691.41542922859;11746.177767556275;11759.470823812864;11768.646940591796;11776.705582360424;11673.941630291794;12396;12528.937355313165;12800.423980920881;13088.541901033419;9788.55951482185;9857.802843943082;9883;10045.397276163454;10299.845502317472;3266.5590145330316;3282.6553211912883;3295.20914980403;3402.5066365376883;3436.9828150859335;39884.80345589637;40075;40081.79959100186;40194.79902600498;41491.37762933588;9693.854592181124;9786.217102631772;9926.652567160114;10023.097921186982;10063.19494440443;17103.315867365414;17160.82839171617;17168.828311716974;17180.828191718174;17190.31238750436;6262.279837818709;6321.936780632135;6349.714262858182;6373.235211774524;6439.581427207217;3591.748577599595;3648.4527320901548;3661.5240018797917;3662.963370366262;3665.725070619714;2827.095329494583;2869.426114777053;2874.396376760862;2875.1087162979543;2880.625518682558;467.0635376070956;472.05353266700735;486.73716193255956;489.7893905620546;546.6064433607796;468.1292795400552;590.6721769417928;592.3720855892767;604.5254475236918;607.6536374266714;6968.512204145661;7404.518706284074;7508.924910750932;7583.2795884392;7589.279018493235;481.1843924547858;496.39439883342266;585.5491271720751;612.1582823617526;621.7192583278461;3579.19468119671;3596.118950857057;3694.5751238607368;3779.8866034019024;3789.621037896188;45056.77471612621;49384;49630.25554616612;49758;49759.25361119586;42789.78605106955;44451.77774111109;44516.77741611271;45196.3220551692;45339.319910201375;39321.41017884734;40637;40721;40841;41273.58726412758;8290.419670622998;8338.874916876373;8348.791280218044;8376.162383761575;8561.529115898686;29763.553546696385;30939;31502.212444689067;31556.526652100696;31735.206619834687;36540;36605.81697091497;38244.23511529809;40701.796491017354;40752.388714168716;9579.9042009579;9651.324407291702;9825.85261221068;9865.358751681119;10145.695629131138;10507.861829887335;10684.679459616224;10731.89268107309;10820.56717731282;11144.33134011962;9708.223342132753;10026.448545330077;10164.89835101669;10204.489775511343;10245.385276883411;9624.230061594915;9861.457619830979;10221.131203847755;10242.539085741011;10579.047885690325;10312.845307320245;10396.376217426978;10420.739481513023;10497.895021049691;10636.255462117888;8829.2495137914;9113.179813816789;9183;9273.211548858435;9274.6290148396;8984.191422771983;9020.278377729897;9200.631974720936;9280.164785169367;9295.349325547417 04:15:48 INFO - PROCESS | 4561 | __end_tp_report 04:15:48 INFO - PROCESS | 4561 | __start_cc_report 04:15:48 INFO - PROCESS | 4561 | _x_x_mozilla_cycle_collect,818 04:15:48 INFO - PROCESS | 4561 | __end_cc_report 04:15:48 INFO - PROCESS | 4561 | __startTimestamp1457698548822__endTimestamp 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | ------- Summary: start ------- 04:15:48 INFO - PROCESS | 4561 | Number of tests: 6 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | [#0] dojo.html Cycles:165 Average:4449.87 Median:4576.22 stddev:444.77 (9.7%) stddev-sans-first:421.27 04:15:48 INFO - PROCESS | 4561 | Values: 2580.7 2589.5 2618.4 2619.7 2634.2 4405.9 4492.1 4523.9 4527.8 4546.0 4488.0 4513.8 4545.7 4547.1 4604.6 4135.6 4148.3 4150.0 4183.1 4264.4 4181.7 4200.3 4232.1 4261.4 4268.5 4047.2 4114.5 4165.2 4213.9 4221.3 4155.3 4183.8 4187.5 4223.2 4229.1 4044.7 4165.6 4178.0 4191.5 4227.8 4395.3 4429.7 4475.8 4482.6 4518.8 4793.3 4815.5 4838.2 4845.9 4873.9 4663.3 4768.3 4861.4 4862.3 4895.5 4467.9 4472.8 4502.5 4505.6 4514.7 4893.0 4908.0 4910.1 4912.0 4947.3 4599.4 4678.1 4716.8 4721.5 4744.1 4803.3 4818.0 4822.5 4849.7 4862.5 4779.0 4782.8 4783.0 4787.1 4826.9 4583.2 4720.9 4749.5 4820.2 4820.3 4031.4 4035.1 4036.7 4039.0 4060.1 3571.5 3571.9 3601.8 3604.8 3611.8 4074.4 4149.3 4152.4 4239.9 4248.0 4785.4 4805.4 4824.0 4824.2 4866.3 4165.8 4170.6 4172.4 4173.6 4208.7 4149.1 4245.5 4297.5 4313.2 4339.1 4573.8 4574.1 4591.9 4592.5 4626.1 4691.2 4851.9 4863.5 4867.6 4901.0 4535.2 4591.8 4594.4 4623.6 4637.6 4703.8 4715.5 4715.6 4716.2 4736.9 4596.6 4718.2 4757.5 4765.1 4807.3 4611.1 4622.8 4627.8 4657.5 4675.0 4638.7 4641.9 4647.1 4681.9 4681.9 4389.4 4543.1 4552.7 4562.6 4652.6 4708.4 4726.5 4743.9 4764.0 4790.0 4569.9 4576.2 4578.5 4606.1 4627.2 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | [#1] ext.html Cycles:180 Average:35636.81 Median:33363.00 stddev:54506.85 (163.4%) stddev-sans-first:54595.88 04:15:48 INFO - PROCESS | 4561 | Values: 490.9 493.2 512.2 548.0 555.2 23420.3 23963.5 23982.8 24017.2 33512.7 36577.5 37003.6 37017.8 37127.3 37155.3 7515.3 7759.9 7764.6 7765.2 7767.3 7681.2 7821.8 7824.5 7826.9 7831.9 7794.8 7873.6 7878.1 7890.1 8101.7 7927.7 8014.6 8016.6 8016.8 8021.8 7778.6 7906.3 7909.0 7909.4 7913.3 36847.8 37500.0 37503.6 37550.0 37662.8 2787.3 2838.6 2894.2 2923.4 3069.4 28288.7 28300.6 28572.6 29146.1 29205.6 3405.0 3465.8 3488.8 3547.3 3575.4 214526.0 215461.0 215510.0 216622.0 216844.0 38553.2 53269.0 53742.7 53827.5 53852.5 36433.3 36546.1 36552.8 36653.6 36737.3 13179.6 13368.6 13375.1 13381.4 13386.9 10593.0 10628.4 10635.6 10638.3 10639.3 13308.9 13347.5 13438.6 13474.2 13551.3 5351.7 5579.7 5580.0 5582.9 5583.6 819.7 832.4 867.5 886.4 904.8 26001.2 26614.9 26770.0 26942.0 26977.3 915.3 926.7 987.7 999.9 1082.7 12774.4 13095.7 13111.0 13278.1 13298.5 252693.0 253162.7 256218.0 256237.0 256467.0 46099.0 46757.3 46873.3 46889.0 46925.3 1037.2 1130.5 1153.1 1162.2 1201.5 23865.2 24208.0 24693.8 24899.0 24957.3 33249.5 33279.0 33569.3 33597.5 33649.0 138826.0 140247.0 140393.0 140413.3 140433.0 24073.9 27978.6 28766.4 28771.4 28913.3 33730.7 41699.0 42181.0 42787.6 43089.6 30039.8 30577.0 30672.8 30734.8 30909.7 32632.8 33258.5 33293.0 33433.0 33827.3 32858.5 33434.2 33534.3 33643.0 33654.0 28483.4 28815.4 29967.4 30346.2 30390.4 23907.5 24047.6 24072.9 24213.3 24299.0 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | [#2] jquery.html Cycles:180 Average:21679.68 Median:4999.31 stddev:56530.70 (1130.8%) stddev-sans-first:56666.56 04:15:48 INFO - PROCESS | 4561 | Values: 332.2 332.6 335.8 337.4 337.7 14289.5 15190.9 15690.5 16306.4 16386.3 11771.9 12157.6 13635.5 14129.2 15347.0 4782.9 4830.9 5003.4 5020.4 5035.8 4919.2 4947.2 4949.1 4977.1 4980.9 3493.5 4830.1 5488.7 5703.3 5703.5 5642.1 5652.8 5652.9 5673.7 5674.8 4809.2 4922.7 4958.0 4999.2 4999.4 17627.5 17677.2 17686.9 17956.4 18934.8 1757.3 1791.7 1808.2 1822.0 1857.5 11876.5 12217.8 12362.9 12590.7 12773.1 1706.8 1793.8 1817.1 1836.3 1842.8 56169.4 57633.0 58975.1 59195.0 59672.7 8652.7 9193.6 9357.7 9397.8 9407.9 11610.5 11717.2 11745.3 11808.5 11811.7 6076.1 6933.6 7137.4 7176.8 7186.0 6476.7 6789.5 6797.4 6820.2 6905.6 5313.7 5381.2 5399.3 5406.9 5474.8 1636.3 1640.6 1659.8 1668.5 1673.1 820.1 853.4 873.4 884.9 891.0 14984.0 15169.2 15450.8 15558.8 15731.5 843.9 855.3 855.3 871.7 907.3 8904.5 8989.2 9130.8 9182.4 9407.8 335763.0 340793.0 344526.0 345721.0 346131.0 70821.6 71315.6 72063.0 74699.3 75497.6 863.5 864.3 888.9 893.1 897.0 13828.4 13971.9 14152.4 14434.9 14447.3 30885.5 31136.5 32244.2 32979.0 33076.8 35129.6 35406.6 43042.6 46135.8 46799.0 6870.5 6891.2 7027.8 7069.8 7075.5 9446.4 10476.7 10707.6 10885.1 11036.8 8952.3 8954.9 9258.7 9318.3 9353.0 4750.7 7965.5 9030.0 9230.2 9706.0 9942.9 9966.0 10087.0 10234.7 10249.1 6984.2 7230.7 7301.9 7377.3 7415.0 8484.9 9510.9 9589.2 9738.9 9777.3 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | [#3] mootools.html Cycles:180 Average:5053.96 Median:5951.43 stddev:2695.08 (45.3%) stddev-sans-first:2687.48 04:15:48 INFO - PROCESS | 4561 | Values: 1250.6 1385.1 1387.8 1505.6 1738.8 6931.1 7073.7 7087.5 7093.6 7097.4 7186.0 7325.3 7338.2 7344.9 7345.6 2018.9 2116.4 2117.3 2117.4 2118.8 2139.5 2176.2 2181.8 2182.1 2186.2 2135.0 2137.3 2159.8 2163.0 2164.4 2169.3 2195.9 2196.4 2196.9 2198.0 2147.5 2189.0 2190.8 2192.1 2192.7 7457.7 7510.0 7511.8 7537.7 7544.2 4246.9 4296.0 4351.4 4358.5 4389.6 2724.8 2793.5 2818.9 2838.3 2841.6 855.8 871.4 882.9 888.1 898.1 10000.3 10181.8 10191.2 10197.0 10221.6 3898.4 4012.6 4020.8 4095.8 4096.6 8742.4 8789.9 8832.9 8848.0 8849.5 4293.7 4307.1 4314.7 4318.6 4325.9 3394.6 3690.5 3807.2 3864.6 3868.0 3392.4 3444.8 3473.6 3484.0 3500.5 1083.1 1087.2 1090.1 1092.0 1100.8 819.7 832.4 838.8 844.9 1106.9 6569.4 6729.2 6729.9 6730.3 6744.7 562.0 567.7 568.9 583.2 722.1 5194.4 5202.8 5206.9 5207.7 5237.4 8338.4 8988.0 9020.3 9302.2 9312.4 9067.2 9090.9 9125.0 9130.3 9133.7 6550.6 6766.6 6786.4 6792.6 7054.0 6838.0 6890.7 6904.0 6905.8 6912.4 7802.3 8092.6 8102.5 8107.8 8240.4 7627.4 7895.1 7905.3 8023.2 8025.8 6010.2 6044.8 6082.8 6108.4 6117.8 6888.3 6894.6 6894.9 6915.1 6942.4 5943.1 6213.1 6222.9 6285.7 6306.4 5344.2 5547.9 5874.3 6039.5 6056.9 6281.2 6298.6 6338.4 6343.9 6378.1 5737.1 5772.4 5804.3 5831.4 5831.4 5909.5 5949.5 5953.4 6071.0 6144.9 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | [#4] prototype.html Cycles:180 Average:4494.81 Median:5158.15 stddev:1333.45 (25.9%) stddev-sans-first:1299.14 04:15:48 INFO - PROCESS | 4561 | Values: 281.4 284.9 293.5 305.7 306.8 5140.6 5145.2 5152.6 5176.1 5195.4 5144.5 5147.5 5148.9 5163.7 5164.0 3837.8 3881.8 3952.5 3959.2 3964.0 4011.2 4018.2 4029.6 4035.4 4036.1 3971.4 3973.9 3980.9 3985.5 3987.0 3818.2 3875.2 3963.6 3970.8 3972.9 3463.5 3469.6 3474.3 3475.1 3479.3 4926.7 4963.7 4967.4 4973.1 4975.7 4562.7 4566.0 4570.7 4577.0 4584.9 5391.1 5397.0 5397.2 5402.5 5405.5 3756.8 3760.2 3763.4 3764.7 3783.9 5437.4 5617.9 5671.1 5677.9 5682.4 3766.2 3781.1 3802.3 3803.2 3806.4 3850.0 3856.7 3864.8 3894.3 3895.7 4466.0 4481.7 4483.5 4503.9 4511.6 5447.8 5453.7 5458.2 5459.8 5463.7 1344.5 1371.0 1373.2 1373.9 1374.5 883.1 909.9 910.1 928.1 932.0 4618.1 4691.2 4779.5 4792.6 4794.8 5606.3 5674.7 5696.9 5698.3 5698.8 4836.1 4837.5 4840.8 4851.0 4851.6 3009.2 3040.5 3043.9 3046.5 3047.7 5372.6 5372.7 5380.6 5382.6 5384.1 5666.2 5830.6 5845.3 5845.7 5847.0 5344.3 5360.7 5374.5 5376.5 5384.0 5667.4 5679.2 5684.8 5690.6 5691.0 5550.4 5555.4 5572.7 5583.3 5596.5 5358.1 5361.8 5366.8 5369.3 5378.1 3702.2 3853.3 3864.3 3879.2 3880.2 5540.8 5557.2 5569.7 5573.3 5577.2 5330.4 5355.8 5369.1 5374.7 5388.7 5387.9 5395.3 5405.5 5407.9 5418.8 5301.0 5302.7 5303.7 5305.7 5312.0 5288.1 5443.2 5445.0 5449.4 5520.1 5297.9 5314.6 5315.5 5318.8 5322.3 04:15:48 INFO - PROCESS | 4561 | 04:15:48 INFO - PROCESS | 4561 | [#5] yui.html Cycles:180 Average:12223.18 Median:45126.55 stddev:13665.11 (30.3%) stddev-sans-first:13675.72 04:15:48 INFO - PROCESS | 4561 | Values: 633.0 657.9 691.0 735.5 748.5 11812.2 12130.5 12130.6 12147.6 12148.3 11621.7 11668.7 11675.9 11683.5 11689.1 619.5 773.8 793.0 811.3 814.0 801.0 804.9 807.4 807.4 807.4 834.9 838.7 839.2 839.4 839.7 646.1 654.1 656.2 832.8 837.6 623.1 624.0 624.4 624.5 624.8 11691.4 11746.2 11759.5 11768.6 11776.7 11673.9 12396.0 12528.9 12800.4 13088.5 9788.6 9857.8 9883.0 10045.4 10299.8 3266.6 3282.7 3295.2 3402.5 3437.0 39884.8 40075.0 40081.8 40194.8 41491.4 9693.9 9786.2 9926.7 10023.1 10063.2 17103.3 17160.8 17168.8 17180.8 17190.3 6262.3 6321.9 6349.7 6373.2 6439.6 3591.7 3648.5 3661.5 3663.0 3665.7 2827.1 2869.4 2874.4 2875.1 2880.6 467.1 472.1 486.7 489.8 546.6 468.1 590.7 592.4 604.5 607.7 6968.5 7404.5 7508.9 7583.3 7589.3 481.2 496.4 585.5 612.2 621.7 3579.2 3596.1 3694.6 3779.9 3789.6 45056.8 49384.0 49630.3 49758.0 49759.3 42789.8 44451.8 44516.8 45196.3 45339.3 39321.4 40637.0 40721.0 40841.0 41273.6 8290.4 8338.9 8348.8 8376.2 8561.5 29763.6 30939.0 31502.2 31556.5 31735.2 36540.0 36605.8 38244.2 40701.8 40752.4 9579.9 9651.3 9825.9 9865.4 10145.7 10507.9 10684.7 10731.9 10820.6 11144.3 9708.2 10026.4 10164.9 10204.5 10245.4 9624.2 9861.5 10221.1 10242.5 10579.0 10312.8 10396.4 10420.7 10497.9 10636.3 8829.2 9113.2 9183.0 9273.2 9274.6 8984.2 9020.3 9200.6 9280.2 9295.3 04:15:48 INFO - PROCESS | 4561 | -------- Summary: end -------- 04:15:48 INFO - PROCESS | 4561 | 04:15:49 INFO - TEST-INFO | 4561: exit 0 04:15:49 INFO - TEST-OK | dromaeo_css | took 1116819ms 04:15:49 INFO - TEST-START | kraken 04:15:49 INFO - operating with platform_type : linux_ 04:15:49 INFO - Initialising browser for kraken test... 04:15:49 INFO - TEST-INFO | started process 4743 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPGiEn/profile http://localhost:41419/getInfo.html) 04:15:54 INFO - PROCESS | 4743 | __metrics Screen width/height:1600/1200 04:15:54 INFO - PROCESS | 4743 | colorDepth:24 04:15:54 INFO - PROCESS | 4743 | Browser inner width/height: 1024/697 04:15:54 INFO - PROCESS | 4743 | __metrics 04:15:55 ERROR - PROCESS | 4743 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:15:55 INFO - PROCESS | 4743 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:15:55 INFO - TEST-INFO | 4743: exit 0 04:15:55 INFO - Browser initialized. 04:15:55 INFO - Running cycle 1/1 for kraken test... 04:15:55 INFO - TEST-INFO | started process 4826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSPGiEn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:07 INFO - PROCESS | 4826 | RSS: Main: 154841088 04:16:07 INFO - PROCESS | 4826 | 04:16:10 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41419/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:11 INFO - PROCESS | 4826 | RSS: Main: 195104768 04:16:11 INFO - PROCESS | 4826 | 04:16:13 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41419/tests/kraken/driver.html?testName=audio-dft) 04:16:14 INFO - PROCESS | 4826 | RSS: Main: 184930304 04:16:14 INFO - PROCESS | 4826 | 04:16:17 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41419/tests/kraken/driver.html?testName=audio-fft) 04:16:18 INFO - PROCESS | 4826 | RSS: Main: 171614208 04:16:18 INFO - PROCESS | 4826 | 04:16:20 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41419/tests/kraken/driver.html?testName=audio-oscillator) 04:16:20 INFO - PROCESS | 4826 | RSS: Main: 173137920 04:16:20 INFO - PROCESS | 4826 | 04:16:23 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41419/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:23 INFO - PROCESS | 4826 | RSS: Main: 175038464 04:16:23 INFO - PROCESS | 4826 | 04:16:26 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41419/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:27 INFO - PROCESS | 4826 | RSS: Main: 174411776 04:16:27 INFO - PROCESS | 4826 | 04:16:31 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41419/tests/kraken/driver.html?testName=imaging-desaturate) 04:16:31 INFO - PROCESS | 4826 | RSS: Main: 174891008 04:16:31 INFO - PROCESS | 4826 | 04:16:34 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41419/tests/kraken/driver.html?testName=json-parse-financial) 04:16:35 INFO - PROCESS | 4826 | RSS: Main: 175538176 04:16:35 INFO - PROCESS | 4826 | 04:16:36 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41419/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:37 INFO - PROCESS | 4826 | RSS: Main: 186249216 04:16:37 INFO - PROCESS | 4826 | 04:16:39 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:39 INFO - PROCESS | 4826 | RSS: Main: 183934976 04:16:39 INFO - PROCESS | 4826 | 04:16:42 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:42 INFO - PROCESS | 4826 | RSS: Main: 194252800 04:16:42 INFO - PROCESS | 4826 | 04:16:45 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:45 INFO - PROCESS | 4826 | RSS: Main: 198717440 04:16:45 INFO - PROCESS | 4826 | 04:16:48 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:49 INFO - PROCESS | 4826 | RSS: Main: 198713344 04:16:49 INFO - PROCESS | 4826 | 04:16:50 INFO - PROCESS | 4826 | Cycle 1(1): loaded http://localhost:41419/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41419/tests/kraken/driver.html?testName=ai-astar) 04:16:51 INFO - PROCESS | 4826 | RSS: Main: 259035136 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | __start_tp_report 04:16:51 INFO - PROCESS | 4826 | _x_x_mozilla_page_load 04:16:51 INFO - PROCESS | 4826 | _x_x_mozilla_page_load_details 04:16:51 INFO - PROCESS | 4826 | |i|pagename|runs| 04:16:51 INFO - PROCESS | 4826 | |0;ai-astar;113;114;110;113;113;113;103;113;113;117 04:16:51 INFO - PROCESS | 4826 | |1;audio-beat-detection;160;134;154;177;132;151;165;136;167;134 04:16:51 INFO - PROCESS | 4826 | |2;audio-dft;163;161;162;162;163;164;165;163;164;166 04:16:51 INFO - PROCESS | 4826 | |3;audio-fft;74;74;101;97;74;75;74;102;102;74 04:16:51 INFO - PROCESS | 4826 | |4;audio-oscillator;96;96;134;96;97;94;139;95;94;138 04:16:51 INFO - PROCESS | 4826 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;118;117;116 04:16:51 INFO - PROCESS | 4826 | |6;imaging-darkroom;147;146;146;148;147;147;146;146;146;146 04:16:51 INFO - PROCESS | 4826 | |7;imaging-desaturate;95;95;96;96;95;95;96;96;95;96 04:16:51 INFO - PROCESS | 4826 | |8;json-parse-financial;68;67;65;65;65;66;66;74;63;64 04:16:51 INFO - PROCESS | 4826 | |9;json-stringify-tinderbox;69;70;70;70;70;70;71;74;69;70 04:16:51 INFO - PROCESS | 4826 | |10;stanford-crypto-aes;83;83;84;86;84;84;83;83;83;85 04:16:51 INFO - PROCESS | 4826 | |11;stanford-crypto-ccm;123;123;120;122;124;121;121;122;120;137 04:16:51 INFO - PROCESS | 4826 | |12;stanford-crypto-pbkdf2;151;144;149;148;151;136;148;148;148;154 04:16:51 INFO - PROCESS | 4826 | |13;stanford-crypto-sha256-iterative;72;70;71;71;73;70;71;70;69;70 04:16:51 INFO - PROCESS | 4826 | __end_tp_report 04:16:51 INFO - PROCESS | 4826 | __start_cc_report 04:16:51 INFO - PROCESS | 4826 | _x_x_mozilla_cycle_collect,1159 04:16:51 INFO - PROCESS | 4826 | __end_cc_report 04:16:51 INFO - PROCESS | 4826 | __startTimestamp1457698611085__endTimestamp 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | ------- Summary: start ------- 04:16:51 INFO - PROCESS | 4826 | Number of tests: 14 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.65 (3.2%) stddev-sans-first:3.86 04:16:51 INFO - PROCESS | 4826 | Values: 113.0 114.0 110.0 113.0 113.0 113.0 103.0 113.0 113.0 117.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:157.00 stddev:16.27 (10.4%) stddev-sans-first:16.93 04:16:51 INFO - PROCESS | 4826 | Values: 160.0 134.0 154.0 177.0 132.0 151.0 165.0 136.0 167.0 134.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 04:16:51 INFO - PROCESS | 4826 | Values: 163.0 161.0 162.0 162.0 163.0 164.0 165.0 163.0 164.0 166.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#3] audio-fft Cycles:10 Average:84.70 Median:74.00 stddev:13.67 (18.5%) stddev-sans-first:13.94 04:16:51 INFO - PROCESS | 4826 | Values: 74.0 74.0 101.0 97.0 74.0 75.0 74.0 102.0 102.0 74.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:95.50 stddev:20.14 (21.1%) stddev-sans-first:20.90 04:16:51 INFO - PROCESS | 4826 | Values: 96.0 96.0 134.0 96.0 97.0 94.0 139.0 95.0 94.0 138.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:16:51 INFO - PROCESS | 4826 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 116.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:16:51 INFO - PROCESS | 4826 | Values: 147.0 146.0 146.0 148.0 147.0 147.0 146.0 146.0 146.0 146.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:16:51 INFO - PROCESS | 4826 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:3.06 (4.6%) stddev-sans-first:3.18 04:16:51 INFO - PROCESS | 4826 | Values: 68.0 67.0 65.0 65.0 65.0 66.0 66.0 74.0 63.0 64.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:1.42 (2.0%) stddev-sans-first:1.42 04:16:51 INFO - PROCESS | 4826 | Values: 69.0 70.0 70.0 70.0 70.0 70.0 71.0 74.0 69.0 70.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 04:16:51 INFO - PROCESS | 4826 | Values: 83.0 83.0 84.0 86.0 84.0 84.0 83.0 83.0 83.0 85.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:122.50 stddev:4.99 (4.1%) stddev-sans-first:5.29 04:16:51 INFO - PROCESS | 4826 | Values: 123.0 123.0 120.0 122.0 124.0 121.0 121.0 122.0 120.0 137.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:148.50 stddev:4.88 (3.3%) stddev-sans-first:5.02 04:16:51 INFO - PROCESS | 4826 | Values: 151.0 144.0 149.0 148.0 151.0 136.0 148.0 148.0 148.0 154.0 04:16:51 INFO - PROCESS | 4826 | 04:16:51 INFO - PROCESS | 4826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.16 (1.6%) stddev-sans-first:1.13 04:16:51 INFO - PROCESS | 4826 | Values: 72.0 70.0 71.0 71.0 73.0 70.0 71.0 70.0 69.0 70.0 04:16:51 INFO - PROCESS | 4826 | -------- Summary: end -------- 04:16:51 INFO - PROCESS | 4826 | 04:16:52 INFO - TEST-INFO | 4826: exit 0 04:16:52 INFO - TEST-OK | kraken | took 62553ms 04:16:52 INFO - SUITE-END | took 1179s 04:16:52 INFO - Completed test suite (00:19:39) 04:16:52 INFO - javascript benchmark 04:16:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2580.6774153230845, 2589.4691588224414, 2618.3977685132413, 2619.7249288824673, 2634.2492389668937, 4405.867823965278, 4492.079123779626, 4523.909521809566, 4527.808548646245, 4545.954540454594, 4487.977560112203, 4513.842015529457, 4545.681802273843, 4547.113312903985, 4604.608608268301, 4135.586441355856, 4148.315527937887, 4150.0, 4183.0797224610615, 4264.42430271914, 4181.686373521983, 4200.327947528381, 4232.111256636094, 4261.403403523509, 4268.487781466229, 4047.170330082326, 4114.506259248879, 4165.187788381267, 4213.936790948138, 4221.345691417835, 4155.252054630166, 4183.769892655902, 4187.476565429321, 4223.176480586287, 4229.069604686964, 4044.716869819114, 4165.645920096796, 4177.97911010443, 4191.497020357577, 4227.8097485613225, 4395.274779661352, 4429.667774916894, 4475.77621118946, 4482.574155455227, 4518.841840535565, 4793.32893394925, 4815.470298267188, 4838.201696720037, 4845.927311090337, 4873.8781530461665, 4663.347131401607, 4768.284757286435, 4861.416630004422, 4862.270659401118, 4895.485973972717, 4467.910641787211, 4472.776361181928, 4502.549745025504, 4505.617022553054, 4514.683972121953, 4893.0, 4908.0, 4910.116179087799, 4911.9754401227765, 4947.282644016597, 4599.40207772994, 4678.087772884255, 4716.764161791897, 4721.504242054603, 4744.051189762062, 4803.255495398219, 4818.036392721469, 4822.517748225219, 4849.709017458893, 4862.513748625109, 4778.952210477851, 4782.832600858953, 4783.019481006385, 4787.0904528139545, 4826.938073623797, 4583.152116858392, 4720.858374248778, 4749.453812811502, 4820.204666230103, 4820.276958456259, 4031.4355990161403, 4035.0921042765144, 4036.737612055207, 4039.0, 4060.1067765091634, 3571.464280357915, 3571.8571257149424, 3601.7658852174527, 3604.7837129772297, 3611.837467313977, 4074.4499492568716, 4149.294619914562, 4152.356384760367, 4239.894002649959, 4248.044190057212, 4785.377900872933, 4805.3512775775525, 4823.975880120647, 4824.204006338915, 4866.270059491034, 4165.770882601425, 4170.603792639695, 4172.415861779354, 4173.582641735863, 4208.684348673862, 4149.128682976609, 4245.490541135084, 4297.527272000078, 4313.245182093184, 4339.067100573392, 4573.794179261875, 4574.08518296342, 4591.931121033121, 4592.540745925515, 4626.074785043005, 4691.225947718588, 4851.854444366674, 4863.513648635108, 4867.561919427269, 4900.975495122501, 4535.206338890615, 4591.816327347003, 4594.448666160082, 4623.630109591292, 4637.582617564435, 4703.811847526061, 4715.504871988392, 4715.622750180046, 4716.1510928033285, 4736.8578942631775, 4596.5863072323655, 4718.221493453541, 4757.452892917358, 4765.0946320199055, 4807.302941073455, 4611.077784443192, 4622.791974361095, 4627.7686115693405, 4657.534246575316, 4674.953250467452, 4638.721676699409, 4641.883952901205, 4647.093816705845, 4681.882952926204, 4681.882952926204, 4389.385486032022, 4543.091381723734, 4552.704074235164, 4562.58936695699, 4652.581267685924, 4708.411448568929, 4726.480087190475, 4743.857684269477, 4764.023375208143, 4790.01804630057, 4569.885752856205, 4576.222042252892, 4578.5421457853945, 4606.078784243098, 4627.167109920112], "unit": "score", "name": "dojo.html", "value": 4423.189417667976}, {"lowerIsBetter": false, "replicates": [490.9067277217331, 493.2034763856371, 512.2495544028, 548.0491347512067, 555.2199160179946, 23420.297391078275, 23963.52072958542, 23982.76017239827, 24017.159399421, 33512.664873351256, 36577.45133822995, 37003.62996370042, 37017.81491092541, 37127.257454850886, 37155.25689486209, 7515.2860478254615, 7759.913612094311, 7764.572948487831, 7765.223477652218, 7767.300942915136, 7681.193474685161, 7821.843563128734, 7824.452288339819, 7826.921730782677, 7831.921680783176, 7794.766157015299, 7873.606319684021, 7878.054633443995, 7890.0531936167745, 8101.716439924604, 7927.682892684285, 8014.599270036504, 8016.63925123368, 8016.799580010488, 8021.799455013671, 7778.6499607517235, 7906.288434040906, 7908.9604551977445, 7909.446338756289, 7913.287804097601, 36847.815760921294, 37500.0, 37503.62496375056, 37550.0, 37662.81168594139, 2787.2753084198052, 2838.6451693538306, 2894.2474956511246, 2923.4153169366214, 3069.3554353585773, 28288.71711282902, 28300.575491367646, 28572.571411428846, 29146.125616231548, 29205.561916571267, 3404.975966926516, 3465.7747246428903, 3488.773229740059, 3547.343741407848, 3575.410057340536, 214526.0, 215461.0, 215510.0, 216622.0, 216844.0, 38553.2289354217, 53269.0, 53742.73128634332, 53827.46172538303, 53852.46147538474, 36433.27133457316, 36546.08634784152, 36552.81723591418, 36653.63346366555, 36737.26525469476, 13179.60461186166, 13368.598942031755, 13375.063745537913, 13381.397837097355, 13386.866131338757, 10593.0, 10628.36229826213, 10635.627753028606, 10638.255322127532, 10639.25525213243, 13308.933455332855, 13347.532836350681, 13438.596842094752, 13474.19154850712, 13551.25468099264, 5351.732413379315, 5579.665220086727, 5579.972100139474, 5582.888342233133, 5583.553315734732, 819.6557445872628, 832.4422636833336, 867.492516877621, 886.3883920095113, 904.7602385367883, 26001.219963401127, 26614.866925665636, 26770.0, 26942.0, 26977.325566860985, 915.3272344826547, 926.7405126564573, 987.6641941739842, 999.9250805384241, 1082.7022568793486, 12774.425150868234, 13095.738085238241, 13111.0, 13278.136921100098, 13298.468061277441, 252693.0, 253162.73418633157, 256218.0, 256237.0, 256467.0, 46099.0, 46757.29864052042, 46873.29690054652, 46889.0, 46925.29612055822, 1037.1650821088945, 1130.496928866663, 1153.0890596428894, 1162.151629310591, 1201.4893670190133, 23865.164719234745, 24208.0, 24693.753062469146, 24899.0, 24957.251282461555, 33249.50125748164, 33279.0, 33569.328613428086, 33597.49603755995, 33649.0, 138826.0, 140247.0, 140393.0, 140413.2979335097, 140433.0, 24073.879630601736, 27978.58032129479, 28766.424671506873, 28771.424571508873, 28913.277168070126, 33730.662693373735, 41699.0, 42181.0, 42787.57212427836, 43089.56910430981, 30039.84980075173, 30577.0, 30672.84663576757, 30734.846325768227, 30909.69090309158, 32632.83683581567, 33258.50112248366, 33293.00604909283, 33433.0, 33827.32345353128, 32858.50712239366, 33434.16414589557, 33534.329313414084, 33643.0, 33654.0, 28483.430331392843, 28815.37246433374, 29967.4006519864, 30346.241343965696, 30390.392192155592, 23907.521849563258, 24047.639285410383, 24072.87963560171, 24213.273601791974, 24299.0], "unit": "score", "name": "ext.html", "value": 15584.740710596729}, {"lowerIsBetter": false, "replicates": [332.1762030165192, 332.57762641445373, 335.8404757740073, 337.37922223109473, 337.71125687537153, 14289.499867504626, 15190.924045379772, 15690.52928412148, 16306.429274975379, 16386.26261818218, 11771.941140294286, 12157.57448489303, 13635.522756703518, 14129.222892740896, 15347.0, 4782.928256076161, 4830.903381932368, 5003.374578177728, 5020.447750747433, 5035.84892453227, 4919.212925931852, 4947.233178857283, 4949.059678661061, 4977.129002424579, 4980.900381992358, 3493.510908472816, 4830.082284365977, 5488.725563721818, 5703.3441154267375, 5703.458171473703, 5642.069058605325, 5652.830415087513, 5652.858678533049, 5673.744681489343, 5674.829755107354, 4809.206480930678, 4922.680025798348, 4958.0, 4999.225120106389, 4999.400071991385, 17627.471175864746, 17677.20452579624, 17686.91156544222, 17956.371526996623, 18934.810651893582, 1757.3497805811803, 1791.6954117800005, 1808.2495764257949, 1821.9908900455546, 1857.544901499128, 11876.52493900243, 12217.755644887142, 12362.938185309016, 12590.74818503634, 12773.105882588223, 1706.7781188445547, 1793.7757780277466, 1817.0914542728635, 1836.2838492987746, 1842.7604411426428, 56169.43830561724, 57633.0, 58975.11537326901, 59195.0, 59672.70163649198, 8652.697155599524, 9193.586288617029, 9357.707361696428, 9397.765055873659, 9407.90592094084, 11610.535578576932, 11717.238379505305, 11745.29528228292, 11808.46861891217, 11811.704707382212, 6076.088586712029, 6933.583984960918, 7137.429005679637, 7176.820579485555, 7186.029885965432, 6476.740930362733, 6789.456843452611, 6797.388235058868, 6820.249772525019, 6905.620190889449, 5313.681179129265, 5381.219723140122, 5399.325084364455, 5406.91889621656, 5474.808381706621, 1636.2882146266413, 1640.5816516788143, 1659.7676325314465, 1668.5077902018934, 1673.0714453478192, 820.1306614988132, 853.3599800149888, 873.4191762478008, 884.8893888263967, 891.0154279521165, 14984.0, 15169.165695886612, 15450.845491545166, 15558.766618500731, 15731.528054158394, 843.9071702112763, 855.2901092093548, 855.3285670748432, 871.7254064969515, 907.2877790934217, 8904.50734845217, 8989.190972812348, 9130.81738365229, 9182.357234993486, 9407.764805879908, 335763.0, 340793.0, 344526.0, 345721.0, 346131.0, 70821.64589177124, 71315.64342178359, 72063.0, 74699.25300746923, 75497.6225118871, 863.5293764898146, 864.304235090758, 888.8844450221429, 893.0801274687083, 897.0312062971975, 13828.446862125402, 13971.860281397463, 14152.43390264378, 14434.855651443351, 14447.277636117942, 30885.536716948813, 31136.532952005284, 32244.19389515281, 32979.0, 33076.83461582773, 35129.64870351366, 35406.64593354137, 43042.56957430386, 46135.76932115318, 46799.0, 6870.484713646397, 6891.241963383924, 7027.824304392431, 7069.823254418475, 7075.540089894141, 9446.38598491096, 10476.68569942903, 10707.571697132027, 10885.129189664649, 11036.779264414827, 8952.28381729447, 8954.910450895408, 9258.722238332592, 9318.254539636677, 9352.953235233781, 4750.667453278375, 7965.522068675898, 9029.954850225708, 9230.169284764135, 9706.0, 9942.900570994487, 9966.0, 10087.0, 10234.692959211236, 10249.128824049742, 6984.21902414881, 7230.710771569078, 7301.890471642823, 7377.3360397564475, 7414.962925185339, 8484.915150848412, 9510.904890951279, 9589.232861370934, 9738.853917191105, 9777.266704997011], "unit": "score", "name": "jquery.html", "value": 7682.788695725985}, {"lowerIsBetter": false, "replicates": [1250.6373151785983, 1385.0581604508934, 1387.8334599848017, 1505.5709122899968, 1738.7913450385956, 6931.133608298963, 7073.717051317941, 7087.4684398670115, 7093.574385536871, 7097.396721278697, 7186.0, 7325.340719335259, 7338.229485903983, 7344.889826652605, 7345.632718364087, 2018.9293374731888, 2116.43914362694, 2117.3436234767196, 2117.375374264588, 2118.8093071623553, 2139.497218153733, 2176.2491940280656, 2181.770914054025, 2182.0726191368603, 2186.2348178137604, 2134.978650213501, 2137.3267420762486, 2159.7948194921455, 2162.9783702162936, 2164.4047886831167, 2169.2624507667388, 2195.9121635134575, 2196.406970118067, 2196.8681879087226, 2197.967030494544, 2147.4738689021133, 2189.0477642225683, 2190.8466407351493, 2192.0683709423433, 2192.7039849620255, 7457.701691932316, 7510.0, 7511.774646760606, 7537.698492060365, 7544.245575442466, 4246.851360202409, 4295.978520107411, 4351.369051487548, 4358.498772641124, 4389.648828093745, 2724.7956403269836, 2793.5111355512704, 2818.9436211275865, 2838.2762395589198, 2841.6163817884526, 855.7817756472122, 871.3856731004627, 882.9028806831243, 888.1251966812684, 898.1198425542939, 10000.299979001473, 10181.79636407275, 10191.184705223564, 10197.0, 10221.591136354537, 3898.434726964574, 4012.578679238638, 4020.8190631421658, 4095.795210239476, 4096.5903409659395, 8742.388032837767, 8789.912100879037, 8832.911670883337, 8847.955760221286, 8849.51327676971, 4293.656507479394, 4307.138572285556, 4314.741115533078, 4318.5681431856565, 4325.891852703645, 3394.6096198936943, 3690.464882592009, 3807.2385522895534, 3864.5555761087835, 3867.9806600966817, 3392.406328892434, 3444.844981975817, 3473.600535938349, 3484.0244731475227, 3500.5274287971306, 1083.149727463937, 1087.2009073331253, 1090.1358676662994, 1092.0280949954547, 1100.834874768791, 819.6721311475338, 832.3632421197789, 838.8364268967492, 844.8986121665439, 1106.8727096384018, 6569.408753212234, 6729.192496900403, 6729.8654026919185, 6730.259671436138, 6744.6627668616375, 562.016471175443, 567.6537312239531, 568.9260396148557, 583.1893667801759, 722.0937723157404, 5194.402643696023, 5202.84391468249, 5206.947930520722, 5207.661502002357, 5237.371515418098, 8338.37462190326, 8988.0, 9020.323475739346, 9302.16280534755, 9312.441253524674, 9067.18395344409, 9090.909090909006, 9124.954375228213, 9130.31522635805, 9133.68032118886, 6550.6069635822005, 6766.594004359853, 6786.423154031864, 6792.626405547742, 7053.964730176316, 6838.04267402574, 6890.724371025103, 6904.03343531916, 6905.792826215222, 6912.377885990285, 7802.29779319864, 8092.595370231583, 8102.513849169069, 8107.797305067184, 8240.423170378015, 7627.389808815171, 7895.1315355309725, 7905.32804711606, 8023.1976802319305, 8025.8394832104195, 6010.248718910137, 6044.758209671564, 6082.847928801815, 6108.389161083856, 6117.785877494266, 6888.276730943179, 6894.620795856276, 6894.8621027580175, 6915.135608048994, 6942.375186233263, 5943.138244954544, 6213.068039793886, 6222.875542489034, 6285.654289014148, 6306.432421082125, 5344.171653393731, 5547.944520554743, 5874.324452687995, 6039.456448919618, 6056.878862422815, 6281.246250449975, 6298.622082675054, 6338.366163383625, 6343.9365606343345, 6378.1070650108095, 5737.053386191232, 5772.422757724194, 5804.303483581997, 5831.387704290988, 5831.446012628793, 5909.497692696169, 5949.494292984971, 5953.374895635896, 6071.0, 6144.907826382697], "unit": "score", "name": "mootools.html", "value": 4075.7974733290894}, {"lowerIsBetter": false, "replicates": [281.36411709536446, 284.94443583501214, 293.5464707027642, 305.68209062574925, 306.789848953467, 5140.640155189134, 5145.202493613491, 5152.562032227256, 5176.1200595898745, 5195.428502864682, 5144.485551444854, 5147.51098645629, 5148.922766158511, 5163.7418129093585, 5163.974180129094, 3837.788921609317, 3881.786501742403, 3952.466417033707, 3959.227950549644, 3964.048628329195, 4011.1576568920414, 4018.1762738638654, 4029.5970402959615, 4035.4148648445957, 4036.071703508195, 3971.3645816669336, 3973.8807835764974, 3980.9203815923665, 3985.5217373915025, 3986.9800650996704, 3818.16000479894, 3875.2249550089814, 3963.564007959122, 3970.8014599269923, 3972.880813575583, 3463.5497385339995, 3469.61834198238, 3474.3398754236614, 3475.131217195701, 3479.3389256041523, 4926.704397736112, 4963.726995015273, 4967.379077615298, 4973.104841128596, 4975.7263350515705, 4562.745245057603, 4566.0, 4570.65720070996, 4576.977115114437, 4584.885377865547, 5391.110466772978, 5397.0, 5397.163439666858, 5402.459754024605, 5405.5135037846785, 3756.835381031889, 3760.2479504099288, 3763.3602287610897, 3764.7176461765475, 3783.9432408513894, 5437.401885792559, 5617.887642247173, 5671.120976248688, 5677.886442271131, 5682.403347648478, 3766.1902690921584, 3781.0736369589076, 3802.2585595809105, 3803.201327721154, 3806.3719486284454, 3849.9807500962875, 3856.6914646828186, 3864.8260828262796, 3894.337962546317, 3895.7272990890365, 4465.955340446554, 4481.663875209372, 4483.461984561808, 4503.91905942578, 4511.571400716926, 5447.809326673548, 5453.700046497402, 5458.235846981426, 5459.754311056012, 5463.699496527729, 1344.4554955243143, 1370.9657258568416, 1373.1898180073804, 1373.8900887928942, 1374.4639590559689, 883.0507204754914, 909.9363044586815, 910.1035480052143, 928.122923836981, 932.0446542294068, 4618.122556714214, 4691.225947718588, 4779.545943135397, 4792.610143058544, 4794.760261986887, 5606.299212598426, 5674.687892165888, 5696.914546281809, 5698.344690360579, 5698.772049118072, 4836.056968891103, 4837.516248375205, 4840.75796210188, 4850.975745121252, 4851.611871050308, 3009.202561321252, 3040.467918114321, 3043.8630261638277, 3046.466868298039, 3047.67999360064, 5372.597055220874, 5372.704501252469, 5380.569554435636, 5382.569394448435, 5384.0847056000575, 5666.2350582670815, 5830.62100963436, 5845.269341332333, 5845.707714614252, 5846.970765146147, 5344.251804747416, 5360.731963401892, 5374.462553744673, 5376.4623537647485, 5383.973080134574, 5667.433256674464, 5679.176519404746, 5684.8294551163535, 5690.630109042899, 5691.0, 5550.389457159628, 5555.3611334697025, 5572.721363931868, 5583.330000399978, 5596.468335508121, 5358.142697168434, 5361.812336568201, 5366.812161574326, 5369.27514785499, 5378.085725426608, 3702.167012422291, 3853.3256680081436, 3864.265789499986, 3879.2047630236298, 3880.185161116084, 5540.833774986757, 5557.221988921635, 5569.693666848362, 5573.27547418833, 5577.191307260506, 5330.387005494263, 5355.78576856937, 5369.140937450145, 5374.704391258519, 5388.676679399092, 5387.86530336729, 5395.298611180679, 5405.5135037846785, 5407.945450637088, 5418.783248670166, 5301.019311427398, 5302.734863256745, 5303.681779093266, 5305.708186049805, 5312.043832110257, 5288.074586947192, 5443.210734443404, 5444.96545656324, 5449.373322068013, 5520.089185284543, 5297.867553311198, 5314.601404894725, 5315.468453154654, 5318.840434786963, 5322.28149199853], "unit": "score", "name": "prototype.html", "value": 4063.556890610718}, {"lowerIsBetter": false, "replicates": [632.9588576742509, 657.8585604095118, 690.951633385663, 735.5329365852683, 748.5134662469396, 11812.232204906686, 12130.514779408835, 12130.636080917575, 12147.574834880781, 12148.27110373377, 11621.709457263572, 11668.708282292946, 11675.941620291887, 11683.532658693663, 11689.12331575133, 619.4579742725116, 773.7562667759652, 793.0443815202696, 811.3428123220181, 814.0394334685069, 800.9719659811908, 804.9154838741906, 807.3621838747382, 807.3742849291787, 807.4347956430493, 834.8539005673982, 838.7316058861167, 839.1608391608391, 839.3872473094644, 839.6515446089866, 646.0599827251338, 654.077750371978, 656.1568384625757, 832.7626626411474, 837.5937670229933, 623.0716232813121, 624.0389799708444, 624.3600309682566, 624.4567226512918, 624.8250489862845, 11691.41542922859, 11746.177767556275, 11759.470823812864, 11768.646940591796, 11776.705582360424, 11673.941630291794, 12396.0, 12528.937355313165, 12800.423980920881, 13088.541901033419, 9788.55951482185, 9857.802843943082, 9883.0, 10045.397276163454, 10299.845502317472, 3266.5590145330316, 3282.6553211912883, 3295.20914980403, 3402.5066365376883, 3436.9828150859335, 39884.80345589637, 40075.0, 40081.79959100186, 40194.79902600498, 41491.37762933588, 9693.854592181124, 9786.217102631772, 9926.652567160114, 10023.097921186982, 10063.19494440443, 17103.315867365414, 17160.82839171617, 17168.828311716974, 17180.828191718174, 17190.31238750436, 6262.279837818709, 6321.936780632135, 6349.714262858182, 6373.235211774524, 6439.581427207217, 3591.748577599595, 3648.4527320901548, 3661.5240018797917, 3662.963370366262, 3665.725070619714, 2827.095329494583, 2869.426114777053, 2874.396376760862, 2875.1087162979543, 2880.625518682558, 467.0635376070956, 472.05353266700735, 486.73716193255956, 489.7893905620546, 546.6064433607796, 468.1292795400552, 590.6721769417928, 592.3720855892767, 604.5254475236918, 607.6536374266714, 6968.512204145661, 7404.518706284074, 7508.924910750932, 7583.2795884392, 7589.279018493235, 481.1843924547858, 496.39439883342266, 585.5491271720751, 612.1582823617526, 621.7192583278461, 3579.19468119671, 3596.118950857057, 3694.5751238607368, 3779.8866034019024, 3789.621037896188, 45056.77471612621, 49384.0, 49630.25554616612, 49758.0, 49759.25361119586, 42789.78605106955, 44451.77774111109, 44516.77741611271, 45196.3220551692, 45339.319910201375, 39321.41017884734, 40637.0, 40721.0, 40841.0, 41273.58726412758, 8290.419670622998, 8338.874916876373, 8348.791280218044, 8376.162383761575, 8561.529115898686, 29763.553546696385, 30939.0, 31502.212444689067, 31556.526652100696, 31735.206619834687, 36540.0, 36605.81697091497, 38244.23511529809, 40701.796491017354, 40752.388714168716, 9579.9042009579, 9651.324407291702, 9825.85261221068, 9865.358751681119, 10145.695629131138, 10507.861829887335, 10684.679459616224, 10731.89268107309, 10820.56717731282, 11144.33134011962, 9708.223342132753, 10026.448545330077, 10164.89835101669, 10204.489775511343, 10245.385276883411, 9624.230061594915, 9861.457619830979, 10221.131203847755, 10242.539085741011, 10579.047885690325, 10312.845307320245, 10396.376217426978, 10420.739481513023, 10497.895021049691, 10636.255462117888, 8829.2495137914, 9113.179813816789, 9183.0, 9273.211548858435, 9274.6290148396, 8984.191422771983, 9020.278377729897, 9200.631974720936, 9280.164785169367, 9295.349325547417], "unit": "score", "name": "yui.html", "value": 5718.728256963571}], "name": "dromaeo_css", "value": 6072.989713676197}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 110.0, 113.0, 113.0, 113.0, 103.0, 113.0, 113.0, 117.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [160.0, 134.0, 154.0, 177.0, 132.0, 151.0, 165.0, 136.0, 167.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 162.0, 163.0, 164.0, 165.0, 163.0, 164.0, 166.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 101.0, 97.0, 74.0, 75.0, 74.0, 102.0, 102.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 134.0, 96.0, 97.0, 94.0, 139.0, 95.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 65.0, 65.0, 65.0, 66.0, 66.0, 74.0, 63.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 74.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 86.0, 84.0, 84.0, 83.0, 83.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [123.0, 123.0, 120.0, 122.0, 124.0, 121.0, 121.0, 122.0, 120.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [151.0, 144.0, 149.0, 148.0, 151.0, 136.0, 148.0, 148.0, 148.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 71.0, 71.0, 73.0, 70.0, 71.0, 70.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1540.1}]} 04:16:52 INFO - Return code: 0 04:16:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:16:52 ERROR - # TBPL SUCCESS # 04:16:52 INFO - Running post-action listener: _resource_record_post_action 04:16:52 INFO - Running post-run listener: _resource_record_post_run 04:16:53 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 102400; Write bytes: 290729984; Read time: 156; Write time: 168808 04:16:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5177344; Read time: 0; Write time: 424 04:16:53 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 102400; Write bytes: 285552640; Read time: 156; Write time: 168384 04:16:53 INFO - Running post-run listener: _upload_blobber_files 04:16:53 INFO - Blob upload gear active. 04:16:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:16:53 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 04:16:53 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'] 04:16:53 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 04:16:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:54 INFO - (blobuploader) - INFO - Done attempting. 04:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:16:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:16:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:16:55 INFO - (blobuploader) - INFO - Done attempting. 04:16:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:16:55 INFO - Return code: 0 04:16:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:16:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:16:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/423be1f402e23239235ab5c4e7410437b46f77d0ff2f29b741c387cb0bf73cc9fbaac9e8768c7c5116bb6bb837b99c1751a361490b214404bf07f8d4cfaed40d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b314aff65adf3be3b7658fbbaef4c19891be60175a71e2b44b77570991ccfb6c699bcba3c731e8028f2d3ddcaec50a00e921c8c916ad33e56b9c0633e138e6c"} 04:16:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:16:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:16:55 INFO - Contents: 04:16:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/423be1f402e23239235ab5c4e7410437b46f77d0ff2f29b741c387cb0bf73cc9fbaac9e8768c7c5116bb6bb837b99c1751a361490b214404bf07f8d4cfaed40d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b314aff65adf3be3b7658fbbaef4c19891be60175a71e2b44b77570991ccfb6c699bcba3c731e8028f2d3ddcaec50a00e921c8c916ad33e56b9c0633e138e6c"} 04:16:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:16:55 INFO - Copying logs to upload dir... 04:16:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:16:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.049753 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-11 04:16:55.441656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 04:16:55.445088) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 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/423be1f402e23239235ab5c4e7410437b46f77d0ff2f29b741c387cb0bf73cc9fbaac9e8768c7c5116bb6bb837b99c1751a361490b214404bf07f8d4cfaed40d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b314aff65adf3be3b7658fbbaef4c19891be60175a71e2b44b77570991ccfb6c699bcba3c731e8028f2d3ddcaec50a00e921c8c916ad33e56b9c0633e138e6c"} build_url:https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/V4Lxg7zWSjCYlNE5DbRAfw/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/423be1f402e23239235ab5c4e7410437b46f77d0ff2f29b741c387cb0bf73cc9fbaac9e8768c7c5116bb6bb837b99c1751a361490b214404bf07f8d4cfaed40d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b314aff65adf3be3b7658fbbaef4c19891be60175a71e2b44b77570991ccfb6c699bcba3c731e8028f2d3ddcaec50a00e921c8c916ad33e56b9c0633e138e6c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 04:16:55.469970) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:16:55.470295) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1457695832.499859-86224832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 04:16:55.555566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 04:16:55.555893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 04:16:55.556186) ========= ========= Total master_lag: 0.29 =========