builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1459502008.63 results: success (0) buildid: 20160401011656 builduid: 7b3226b886014956938a6b21a9b0f061 revision: 712a70746d183ee33e00bc06efd48de25b7332a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.634695) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.635305) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.635616) ========= 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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006450 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.663996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.664347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.699090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.699469) ========= 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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.750242) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.750530) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.750896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.751168) ========= 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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 02:13:29-- 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% 225M=0s 2016-04-01 02:13:29 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146812 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.910765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.911080) ========= 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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020427 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:28.963681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-01 02:13:28.964019) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 712a70746d183ee33e00bc06efd48de25b7332a7 --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 712a70746d183ee33e00bc06efd48de25b7332a7 --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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 02:13:29,429 truncating revision to first 12 chars 2016-04-01 02:13:29,429 Setting DEBUG logging. 2016-04-01 02:13:29,429 attempt 1/10 2016-04-01 02:13:29,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/712a70746d18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 02:13:31,958 unpacking tar archive at: fx-team-712a70746d18/testing/mozharness/ program finished with exit code 0 elapsedTime=2.793298 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-01 02:13:31.770311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:31.770665) ========= echo 712a70746d183ee33e00bc06efd48de25b7332a7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'712a70746d183ee33e00bc06efd48de25b7332a7'] 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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 712a70746d183ee33e00bc06efd48de25b7332a7 program finished with exit code 0 elapsedTime=0.004814 script_repo_revision: '712a70746d183ee33e00bc06efd48de25b7332a7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:31.821851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:31.822147) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 02:13:31.833747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-01 02:13:31.834022) ========= /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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:13:32 INFO - MultiFileLogger online at 20160401 02:13:32 in /builds/slave/test 02:13:32 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 02:13:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:32 INFO - {'append_to_log': False, 02:13:32 INFO - 'base_work_dir': '/builds/slave/test', 02:13:32 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:13:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:32 INFO - 'branch': 'Fx-Team-Non-PGO', 02:13:32 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:32 INFO - 'config_files': ('talos/linux_config.py',), 02:13:32 INFO - 'default_actions': ('clobber', 02:13:32 INFO - 'read-buildbot-config', 02:13:32 INFO - 'download-and-extract', 02:13:32 INFO - 'populate-webroot', 02:13:32 INFO - 'create-virtualenv', 02:13:32 INFO - 'install', 02:13:32 INFO - 'run-tests'), 02:13:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:32 INFO - 'download_minidump_stackwalk': True, 02:13:32 INFO - 'download_symbols': 'ondemand', 02:13:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:32 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:32 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:32 INFO - 'installer_path': 'installer.exe', 02:13:32 INFO - 'log_level': 'info', 02:13:32 INFO - 'log_name': 'talos', 02:13:32 INFO - 'log_to_console': True, 02:13:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:13:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:13:32 INFO - 'opt_config_files': (), 02:13:32 INFO - 'pip_index': False, 02:13:32 INFO - 'sps_profile': False, 02:13:32 INFO - 'sps_profile_interval': 0, 02:13:32 INFO - 'suite': 'dromaeojs', 02:13:32 INFO - 'system_bits': '32', 02:13:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:32 INFO - 'title': 'talos-linux64-ix-058', 02:13:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:32 INFO - 'use_talos_json': True, 02:13:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:32 INFO - 'work_dir': 'build'} 02:13:32 INFO - ##### 02:13:32 INFO - ##### Running clobber step. 02:13:32 INFO - ##### 02:13:32 INFO - Running pre-action listener: _resource_record_pre_action 02:13:32 INFO - Running main action method: clobber 02:13:32 INFO - rmtree: /builds/slave/test/build 02:13:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:13:32 INFO - Running post-action listener: _resource_record_post_action 02:13:32 INFO - ##### 02:13:32 INFO - ##### Running read-buildbot-config step. 02:13:32 INFO - ##### 02:13:32 INFO - Running pre-action listener: _resource_record_pre_action 02:13:32 INFO - Running main action method: read_buildbot_config 02:13:32 INFO - Using buildbot properties: 02:13:32 INFO - { 02:13:32 INFO - "project": "", 02:13:32 INFO - "product": "firefox", 02:13:32 INFO - "script_repo_revision": "production", 02:13:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:13:32 INFO - "repository": "", 02:13:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:13:32 INFO - "buildid": "20160401011656", 02:13:32 INFO - "pgo_build": "False", 02:13:32 INFO - "basedir": "/builds/slave/test", 02:13:32 INFO - "buildnumber": 1516, 02:13:32 INFO - "slavename": "talos-linux64-ix-058", 02:13:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:13:32 INFO - "platform": "ubuntu64_hw", 02:13:32 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:13:32 INFO - "branch": "fx-team", 02:13:32 INFO - "repo_path": "integration/fx-team", 02:13:32 INFO - "revision": "712a70746d183ee33e00bc06efd48de25b7332a7", 02:13:32 INFO - "stage_platform": "linux64", 02:13:32 INFO - "builduid": "7b3226b886014956938a6b21a9b0f061", 02:13:32 INFO - "slavebuilddir": "test" 02:13:32 INFO - } 02:13:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:13:32 INFO - Running post-action listener: _resource_record_post_action 02:13:32 INFO - ##### 02:13:32 INFO - ##### Running download-and-extract step. 02:13:32 INFO - ##### 02:13:32 INFO - Running pre-action listener: _resource_record_pre_action 02:13:32 INFO - Running main action method: download_and_extract 02:13:32 INFO - mkdir: /builds/slave/test/build/tests 02:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:32 INFO - https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:13:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:13:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:13:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:34 INFO - Downloaded 1361 bytes. 02:13:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:13:34 INFO - Using the following test package requirements: 02:13:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:13:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:13:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:13:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'jsshell-linux-x86_64.zip'], 02:13:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:13:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:13:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:13:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:13:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:13:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:13:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:13:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:13: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')]} 02:13:34 INFO - https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:35 INFO - Downloaded 22111534 bytes. 02:13:35 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'] 02:13:35 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 02:13:36 INFO - Return code: 0 02:13:36 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 02:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:36 INFO - https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:38 INFO - Downloaded 22111534 bytes. 02:13:38 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'] 02:13:38 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 02:13:40 INFO - Return code: 0 02:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:40 INFO - https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:13:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:13:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:41 INFO - Downloaded 10847534 bytes. 02:13:41 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'] 02:13:41 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 02:13:41 INFO - Return code: 0 02:13:41 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')]} 02:13:41 INFO - https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fPvF8l_xQtausuN0bezFSg/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 02:13:42 INFO - Downloaded 54224003 bytes. 02:13:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:13:42 INFO - mkdir: /builds/slave/test/properties 02:13:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:42 INFO - Contents: 02:13:42 INFO - build_url:https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:13:43 INFO - Running post-action listener: _resource_record_post_action 02:13:43 INFO - Running post-action listener: set_extra_try_arguments 02:13:43 INFO - ##### 02:13:43 INFO - ##### Running populate-webroot step. 02:13:43 INFO - ##### 02:13:43 INFO - Running pre-action listener: _resource_record_pre_action 02:13:43 INFO - Running main action method: populate_webroot 02:13:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:43 INFO - '--tppagecycles', 02:13:43 INFO - '7'], 02:13:43 INFO - 'tests': ['tsvgm']}}, 02:13:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:13:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:13:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'tests': ['damp', 'tps']}, 02:13:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['damp', 'tps']}, 02:13:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:13:43 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['dromaeo_dom']}, 02:13:43 INFO - 'other': {'tests': ['a11yr', 02:13:43 INFO - 'ts_paint', 02:13:43 INFO - 'tpaint', 02:13:43 INFO - 'sessionrestore', 02:13:43 INFO - 'sessionrestore_no_auto_restore', 02:13:43 INFO - 'tabpaint']}, 02:13:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['a11yr', 02:13:43 INFO - 'ts_paint', 02:13:43 INFO - 'tpaint', 02:13:43 INFO - 'sessionrestore', 02:13:43 INFO - 'sessionrestore_no_auto_restore', 02:13:43 INFO - 'tabpaint']}, 02:13:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['a11yr', 02:13:43 INFO - 'ts_paint', 02:13:43 INFO - 'tpaint', 02:13:43 INFO - 'sessionrestore', 02:13:43 INFO - 'sessionrestore_no_auto_restore', 02:13:43 INFO - 'tabpaint']}, 02:13:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['a11yr', 02:13:43 INFO - 'ts_paint', 02:13:43 INFO - 'tpaint', 02:13:43 INFO - 'sessionrestore', 02:13:43 INFO - 'sessionrestore_no_auto_restore', 02:13:43 INFO - 'tabpaint']}, 02:13:43 INFO - 'other_l64': {'tests': ['a11yr', 02:13:43 INFO - 'ts_paint', 02:13:43 INFO - 'tpaint', 02:13:43 INFO - 'sessionrestore', 02:13:43 INFO - 'sessionrestore_no_auto_restore', 02:13:43 INFO - 'tabpaint']}, 02:13:43 INFO - 'other_nol64': {'tests': ['a11yr', 02:13:43 INFO - 'ts_paint', 02:13:43 INFO - 'tpaint', 02:13:43 INFO - 'sessionrestore', 02:13:43 INFO - 'sessionrestore_no_auto_restore', 02:13:43 INFO - 'tabpaint']}, 02:13:43 INFO - 'svgr': {'tests': ['tsvgx', 02:13:43 INFO - 'tsvgr_opacity', 02:13:43 INFO - 'tart', 02:13:43 INFO - 'tscrollx', 02:13:43 INFO - 'cart']}, 02:13:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['tsvgx', 02:13:43 INFO - 'tsvgr_opacity', 02:13:43 INFO - 'tart', 02:13:43 INFO - 'tscrollx', 02:13:43 INFO - 'cart']}, 02:13:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'tests': ['tp5o']}, 02:13:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'talos_options': ['--e10s'], 02:13:43 INFO - 'tests': ['tp5o']}, 02:13:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'talos_options': ['--xperf_path', 02:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:43 INFO - 'tests': ['tp5n']}, 02:13:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:13:43 INFO - 'talos_options': ['--e10s', 02:13:43 INFO - '--xperf_path', 02:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:43 INFO - 'tests': ['tp5n']}}, 02:13:43 INFO - 'talos.zip': {'path': '', 02:13:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:43 INFO - Running post-action listener: _resource_record_post_action 02:13:43 INFO - ##### 02:13:43 INFO - ##### Running create-virtualenv step. 02:13:43 INFO - ##### 02:13:43 INFO - Running pre-action listener: _resource_record_pre_action 02:13:43 INFO - Running main action method: create_virtualenv 02:13:43 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:43 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 02:13:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:43 INFO - Using real prefix '/usr' 02:13:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:44 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:46 INFO - Installing pip.................done. 02:13:46 INFO - Return code: 0 02:13:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:13:46 INFO - Using env: {'DISPLAY': ':0', 02:13:46 INFO - 'HOME': '/home/cltbld', 02:13:46 INFO - 'LANG': 'en_US.UTF-8', 02:13:46 INFO - 'LANGUAGE': 'en_US:en', 02:13:46 INFO - 'LOGNAME': 'cltbld', 02:13:46 INFO - 'MAIL': '/var/mail/cltbld', 02:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:46 INFO - 'MOZ_NO_REMOTE': '1', 02:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:46 INFO - 'NO_EM_RESTART': '1', 02:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:46 INFO - 'PWD': '/builds/slave/test', 02:13:46 INFO - 'SHELL': '/bin/bash', 02:13:46 INFO - 'SHLVL': '1', 02:13:46 INFO - 'TERM': 'linux', 02:13:46 INFO - 'TMOUT': '86400', 02:13:46 INFO - 'USER': 'cltbld', 02:13:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:46 INFO - '_': '/tools/buildbot/bin/python'} 02:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:46 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 02:13:46 INFO - Cleaning up... 02:13:46 INFO - Return code: 0 02:13:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:13:46 INFO - Using env: {'DISPLAY': ':0', 02:13:46 INFO - 'HOME': '/home/cltbld', 02:13:46 INFO - 'LANG': 'en_US.UTF-8', 02:13:46 INFO - 'LANGUAGE': 'en_US:en', 02:13:46 INFO - 'LOGNAME': 'cltbld', 02:13:46 INFO - 'MAIL': '/var/mail/cltbld', 02:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:46 INFO - 'MOZ_NO_REMOTE': '1', 02:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:46 INFO - 'NO_EM_RESTART': '1', 02:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:46 INFO - 'PWD': '/builds/slave/test', 02:13:46 INFO - 'SHELL': '/bin/bash', 02:13:46 INFO - 'SHLVL': '1', 02:13:46 INFO - 'TERM': 'linux', 02:13:46 INFO - 'TMOUT': '86400', 02:13:46 INFO - 'USER': 'cltbld', 02:13:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:46 INFO - '_': '/tools/buildbot/bin/python'} 02:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:46 INFO - Downloading/unpacking psutil>=0.7.1 02:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:48 INFO - Installing collected packages: psutil 02:13:48 INFO - Running setup.py install for psutil 02:13:48 INFO - building 'psutil._psutil_linux' extension 02:13:48 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 02:13:48 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 02:13:48 INFO - building 'psutil._psutil_posix' extension 02:13:48 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 02:13:48 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 02:13:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:48 INFO - Successfully installed psutil 02:13:48 INFO - Cleaning up... 02:13:49 INFO - Return code: 0 02:13:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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', '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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:13: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:13: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 mozsystemmonitor==0.0.0 02:13:49 INFO - Using env: {'DISPLAY': ':0', 02:13:49 INFO - 'HOME': '/home/cltbld', 02:13:49 INFO - 'LANG': 'en_US.UTF-8', 02:13:49 INFO - 'LANGUAGE': 'en_US:en', 02:13:49 INFO - 'LOGNAME': 'cltbld', 02:13:49 INFO - 'MAIL': '/var/mail/cltbld', 02:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:49 INFO - 'MOZ_NO_REMOTE': '1', 02:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:49 INFO - 'NO_EM_RESTART': '1', 02:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:49 INFO - 'PWD': '/builds/slave/test', 02:13:49 INFO - 'SHELL': '/bin/bash', 02:13:49 INFO - 'SHLVL': '1', 02:13:49 INFO - 'TERM': 'linux', 02:13:49 INFO - 'TMOUT': '86400', 02:13:49 INFO - 'USER': 'cltbld', 02:13:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:49 INFO - '_': '/tools/buildbot/bin/python'} 02:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:13:51 INFO - Installing collected packages: mozsystemmonitor 02:13:51 INFO - Running setup.py install for mozsystemmonitor 02:13:51 INFO - Successfully installed mozsystemmonitor 02:13:51 INFO - Cleaning up... 02:13:51 INFO - Return code: 0 02:13:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:51 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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:13:51 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 02:13:51 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 02:13:51 INFO - Using env: {'DISPLAY': ':0', 02:13:51 INFO - 'HOME': '/home/cltbld', 02:13:51 INFO - 'LANG': 'en_US.UTF-8', 02:13:51 INFO - 'LANGUAGE': 'en_US:en', 02:13:51 INFO - 'LOGNAME': 'cltbld', 02:13:51 INFO - 'MAIL': '/var/mail/cltbld', 02:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:51 INFO - 'MOZ_NO_REMOTE': '1', 02:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:51 INFO - 'NO_EM_RESTART': '1', 02:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:51 INFO - 'PWD': '/builds/slave/test', 02:13:51 INFO - 'SHELL': '/bin/bash', 02:13:51 INFO - 'SHLVL': '1', 02:13:51 INFO - 'TERM': 'linux', 02:13:51 INFO - 'TMOUT': '86400', 02:13:51 INFO - 'USER': 'cltbld', 02:13:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:51 INFO - '_': '/tools/buildbot/bin/python'} 02:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:13:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:13:53 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 02:13:53 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 02:13:53 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 02:13:53 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 02:13:53 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 02:13:53 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 02:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:13:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13:53 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 02:13:53 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 02:13:53 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 02:13:53 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 02:13:53 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 02:13:53 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 02:13:54 INFO - Downloading docopt-0.6.1.tar.gz 02:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:54 INFO - Running setup.py install for blobuploader 02:13:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:13:54 INFO - Running setup.py install for requests 02:13:54 INFO - Running setup.py install for docopt 02:13:54 INFO - Successfully installed blobuploader requests docopt 02:13:54 INFO - Cleaning up... 02:13:54 INFO - Return code: 0 02:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:54 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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:13:54 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 02:13:54 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 02:13:54 INFO - Using env: {'DISPLAY': ':0', 02:13:54 INFO - 'HOME': '/home/cltbld', 02:13:54 INFO - 'LANG': 'en_US.UTF-8', 02:13:54 INFO - 'LANGUAGE': 'en_US:en', 02:13:54 INFO - 'LOGNAME': 'cltbld', 02:13:54 INFO - 'MAIL': '/var/mail/cltbld', 02:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:54 INFO - 'MOZ_NO_REMOTE': '1', 02:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:54 INFO - 'NO_EM_RESTART': '1', 02:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:54 INFO - 'PWD': '/builds/slave/test', 02:13:54 INFO - 'SHELL': '/bin/bash', 02:13:54 INFO - 'SHLVL': '1', 02:13:54 INFO - 'TERM': 'linux', 02:13:54 INFO - 'TMOUT': '86400', 02:13:54 INFO - 'USER': 'cltbld', 02:13:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:54 INFO - '_': '/tools/buildbot/bin/python'} 02:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:54 INFO - Running setup.py (path:/tmp/pip-xRCRwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:55 INFO - Running setup.py (path:/tmp/pip-6AEUK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:55 INFO - Running setup.py (path:/tmp/pip-Y1PDfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:55 INFO - Running setup.py (path:/tmp/pip-IMCAII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:55 INFO - Running setup.py (path:/tmp/pip-5xFD8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:55 INFO - Running setup.py (path:/tmp/pip-PTYMqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:55 INFO - Running setup.py (path:/tmp/pip-pveWjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:55 INFO - Running setup.py (path:/tmp/pip-q081hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:55 INFO - Running setup.py (path:/tmp/pip-5ZYiHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:55 INFO - Running setup.py (path:/tmp/pip-uWC8Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:55 INFO - Running setup.py (path:/tmp/pip-BDkk_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:55 INFO - Running setup.py (path:/tmp/pip-vfQs1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:55 INFO - Running setup.py (path:/tmp/pip-SHKNkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:55 INFO - Running setup.py (path:/tmp/pip-NcE8xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:55 INFO - Running setup.py (path:/tmp/pip-ojwcdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:56 INFO - Running setup.py (path:/tmp/pip-feQb6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:56 INFO - Running setup.py (path:/tmp/pip-eId_pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:56 INFO - Running setup.py install for manifestparser 02:13:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Running setup.py install for mozcrash 02:13:56 INFO - Running setup.py install for mozdebug 02:13:56 INFO - Running setup.py install for mozdevice 02:13:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Running setup.py install for mozfile 02:13:56 INFO - Running setup.py install for mozhttpd 02:13:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Running setup.py install for mozinfo 02:13:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Running setup.py install for mozInstall 02:13:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:13:56 INFO - Running setup.py install for mozleak 02:13:57 INFO - Running setup.py install for mozlog 02:13:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:13:57 INFO - Running setup.py install for moznetwork 02:13:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:13:57 INFO - Running setup.py install for mozprocess 02:13:57 INFO - Running setup.py install for mozprofile 02:13:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:13:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:13:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:13:57 INFO - Running setup.py install for mozrunner 02:13:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:13:57 INFO - Running setup.py install for mozscreenshot 02:13:57 INFO - Running setup.py install for moztest 02:13:57 INFO - Running setup.py install for mozversion 02:13:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:13:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:58 INFO - Cleaning up... 02:13:58 INFO - Return code: 0 02:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:58 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')]} 02:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:58 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')]} 02:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:58 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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:13:58 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 02:13:58 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 02:13:58 INFO - Using env: {'DISPLAY': ':0', 02:13:58 INFO - 'HOME': '/home/cltbld', 02:13:58 INFO - 'LANG': 'en_US.UTF-8', 02:13:58 INFO - 'LANGUAGE': 'en_US:en', 02:13:58 INFO - 'LOGNAME': 'cltbld', 02:13:58 INFO - 'MAIL': '/var/mail/cltbld', 02:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:58 INFO - 'MOZ_NO_REMOTE': '1', 02:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:58 INFO - 'NO_EM_RESTART': '1', 02:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:58 INFO - 'PWD': '/builds/slave/test', 02:13:58 INFO - 'SHELL': '/bin/bash', 02:13:58 INFO - 'SHLVL': '1', 02:13:58 INFO - 'TERM': 'linux', 02:13:58 INFO - 'TMOUT': '86400', 02:13:58 INFO - 'USER': 'cltbld', 02:13:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:58 INFO - '_': '/tools/buildbot/bin/python'} 02:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:58 INFO - Running setup.py (path:/tmp/pip-m89kHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:58 INFO - Running setup.py (path:/tmp/pip-diVVUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:58 INFO - Running setup.py (path:/tmp/pip-HWm3W3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:58 INFO - Running setup.py (path:/tmp/pip-sbZ54m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:58 INFO - Running setup.py (path:/tmp/pip-adPnCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:58 INFO - Running setup.py (path:/tmp/pip-z2B8nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:58 INFO - Running setup.py (path:/tmp/pip-f2YGfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:58 INFO - Running setup.py (path:/tmp/pip-lt9LVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:58 INFO - Running setup.py (path:/tmp/pip-EK3xed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:58 INFO - Running setup.py (path:/tmp/pip-Ey8yUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:58 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)) 02:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:58 INFO - Running setup.py (path:/tmp/pip-4UebKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:59 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)) 02:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:59 INFO - Running setup.py (path:/tmp/pip-Swqtgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:59 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)) 02:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:59 INFO - Running setup.py (path:/tmp/pip-KpzEKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:59 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)) 02:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:59 INFO - Running setup.py (path:/tmp/pip-gvl6aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:59 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)) 02:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:59 INFO - Running setup.py (path:/tmp/pip-JbDym6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:59 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)) 02:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:59 INFO - Running setup.py (path:/tmp/pip-kmhyQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:59 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)) 02:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:59 INFO - Running setup.py (path:/tmp/pip-y6ARBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:59 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)) 02:13:59 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)) 02:13:59 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)) 02:13:59 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)) 02:13:59 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)) 02:13:59 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)) 02:13:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:59 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 02:13:59 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 02:13:59 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 02:13:59 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 02:13:59 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 02:13:59 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 02:14:01 INFO - Downloading blessings-1.6.tar.gz 02:14:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:01 INFO - Installing collected packages: blessings 02:14:01 INFO - Running setup.py install for blessings 02:14:01 INFO - Successfully installed blessings 02:14:01 INFO - Cleaning up... 02:14:01 INFO - Return code: 0 02:14:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:01 INFO - Reading from file tmpfile_stdout 02:14:01 INFO - Current package versions: 02:14:01 INFO - argparse == 1.2.1 02:14:01 INFO - blessings == 1.6 02:14:01 INFO - blobuploader == 1.2.4 02:14:01 INFO - docopt == 0.6.1 02:14:01 INFO - manifestparser == 1.1 02:14:01 INFO - mozInstall == 1.12 02:14:01 INFO - mozcrash == 0.17 02:14:01 INFO - mozdebug == 0.1 02:14:01 INFO - mozdevice == 0.48 02:14:01 INFO - mozfile == 1.2 02:14:01 INFO - mozhttpd == 0.7 02:14:01 INFO - mozinfo == 0.9 02:14:01 INFO - mozleak == 0.1 02:14:01 INFO - mozlog == 3.1 02:14:01 INFO - moznetwork == 0.27 02:14:01 INFO - mozprocess == 0.22 02:14:01 INFO - mozprofile == 0.28 02:14:01 INFO - mozrunner == 6.11 02:14:01 INFO - mozscreenshot == 0.1 02:14:01 INFO - mozsystemmonitor == 0.0 02:14:01 INFO - moztest == 0.7 02:14:01 INFO - mozversion == 1.4 02:14:01 INFO - psutil == 3.1.1 02:14:01 INFO - requests == 1.2.3 02:14:01 INFO - wsgiref == 0.1.2 02:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:14:01 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 02:14:01 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 02:14:01 INFO - Using env: {'DISPLAY': ':0', 02:14:01 INFO - 'HOME': '/home/cltbld', 02:14:01 INFO - 'LANG': 'en_US.UTF-8', 02:14:01 INFO - 'LANGUAGE': 'en_US:en', 02:14:01 INFO - 'LOGNAME': 'cltbld', 02:14:01 INFO - 'MAIL': '/var/mail/cltbld', 02:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:01 INFO - 'MOZ_NO_REMOTE': '1', 02:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:01 INFO - 'NO_EM_RESTART': '1', 02:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:01 INFO - 'PWD': '/builds/slave/test', 02:14:01 INFO - 'SHELL': '/bin/bash', 02:14:01 INFO - 'SHLVL': '1', 02:14:01 INFO - 'TERM': 'linux', 02:14:01 INFO - 'TMOUT': '86400', 02:14:01 INFO - 'USER': 'cltbld', 02:14:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:01 INFO - '_': '/tools/buildbot/bin/python'} 02:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 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)) 02:14:02 INFO - Cleaning up... 02:14:02 INFO - Return code: 0 02:14:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:02 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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:14:02 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 02:14:02 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 02:14:02 INFO - Using env: {'DISPLAY': ':0', 02:14:02 INFO - 'HOME': '/home/cltbld', 02:14:02 INFO - 'LANG': 'en_US.UTF-8', 02:14:02 INFO - 'LANGUAGE': 'en_US:en', 02:14:02 INFO - 'LOGNAME': 'cltbld', 02:14:02 INFO - 'MAIL': '/var/mail/cltbld', 02:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:02 INFO - 'MOZ_NO_REMOTE': '1', 02:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:02 INFO - 'NO_EM_RESTART': '1', 02:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:02 INFO - 'PWD': '/builds/slave/test', 02:14:02 INFO - 'SHELL': '/bin/bash', 02:14:02 INFO - 'SHLVL': '1', 02:14:02 INFO - 'TERM': 'linux', 02:14:02 INFO - 'TMOUT': '86400', 02:14:02 INFO - 'USER': 'cltbld', 02:14:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:02 INFO - '_': '/tools/buildbot/bin/python'} 02:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:02 INFO - Downloading/unpacking jsonschema 02:14:02 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 02:14:02 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 02:14:02 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 02:14:02 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 02:14:02 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 02:14:02 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 02:14:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:04 INFO - Downloading/unpacking functools32 (from jsonschema) 02:14:04 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 02:14:04 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 02:14:04 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 02:14:04 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 02:14:04 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 02:14:04 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 02:14:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:04 INFO - warning: no files found matching '*.txt' 02:14:04 INFO - no previously-included directories found matching 'build' 02:14:04 INFO - no previously-included directories found matching 'dist' 02:14:04 INFO - no previously-included directories found matching '.git*' 02:14:04 INFO - Installing collected packages: jsonschema, functools32 02:14:04 INFO - Running setup.py install for functools32 02:14:04 INFO - warning: no files found matching '*.txt' 02:14:04 INFO - no previously-included directories found matching 'build' 02:14:04 INFO - no previously-included directories found matching 'dist' 02:14:04 INFO - no previously-included directories found matching '.git*' 02:14:04 INFO - Successfully installed jsonschema functools32 02:14:04 INFO - Cleaning up... 02:14:04 INFO - Return code: 0 02:14:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:04 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 0x7fde70279f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, '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': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', '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 02:14:04 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 02:14:04 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 02:14:04 INFO - Using env: {'DISPLAY': ':0', 02:14:04 INFO - 'HOME': '/home/cltbld', 02:14:04 INFO - 'LANG': 'en_US.UTF-8', 02:14:04 INFO - 'LANGUAGE': 'en_US:en', 02:14:04 INFO - 'LOGNAME': 'cltbld', 02:14:04 INFO - 'MAIL': '/var/mail/cltbld', 02:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:04 INFO - 'MOZ_NO_REMOTE': '1', 02:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:04 INFO - 'NO_EM_RESTART': '1', 02:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:04 INFO - 'PWD': '/builds/slave/test', 02:14:04 INFO - 'SHELL': '/bin/bash', 02:14:04 INFO - 'SHLVL': '1', 02:14:04 INFO - 'TERM': 'linux', 02:14:04 INFO - 'TMOUT': '86400', 02:14:04 INFO - 'USER': 'cltbld', 02:14:04 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:04 INFO - '_': '/tools/buildbot/bin/python'} 02:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:04 INFO - Downloading/unpacking flake8 02:14:04 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 02:14:04 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 02:14:04 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 02:14:04 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 02:14:04 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 02:14:04 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 02:14:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:14:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:14:06 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 02:14:06 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 02:14:06 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 02:14:06 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 02:14:06 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 02:14:06 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 02:14:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:14:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:14:06 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 02:14:06 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 02:14:06 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 02:14:06 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 02:14:06 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 02:14:06 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 02:14:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:14:07 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 02:14:07 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 02:14:07 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 02:14:07 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 02:14:07 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 02:14:07 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 02:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:14:07 INFO - no previously-included directories found matching 'docs/_build' 02:14:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:14:07 INFO - Running setup.py install for pep8 02:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:14:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:14:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:14:07 INFO - no previously-included directories found matching 'docs/_build' 02:14:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:14:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:14:07 INFO - Cleaning up... 02:14:07 INFO - Return code: 0 02:14:07 INFO - Running post-action listener: _resource_record_post_action 02:14:07 INFO - Running post-action listener: _start_resource_monitoring 02:14:07 INFO - Starting resource monitoring. 02:14:07 INFO - ##### 02:14:07 INFO - ##### Running install step. 02:14:07 INFO - ##### 02:14:07 INFO - Running pre-action listener: _resource_record_pre_action 02:14:07 INFO - Running main action method: install 02:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:07 INFO - Reading from file tmpfile_stdout 02:14:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:07 INFO - Reading from file tmpfile_stdout 02:14:07 INFO - Output received: 02:14:07 INFO - Usage: mozinstall [options] installer 02:14:07 INFO - Options: 02:14:07 INFO - -h, --help show this help message and exit 02:14:07 INFO - -d DEST, --destination=DEST 02:14:07 INFO - Directory to install application into. [default: 02:14:07 INFO - "/builds/slave/test"] 02:14:07 INFO - --app=APP Application being installed. [default: firefox] 02:14:07 INFO - mkdir: /builds/slave/test/build/application 02:14:07 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'] 02:14:07 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 02:14:23 INFO - Reading from file tmpfile_stdout 02:14:23 INFO - Output received: 02:14:23 INFO - /builds/slave/test/build/application/firefox/firefox 02:14:23 INFO - Running post-action listener: _resource_record_post_action 02:14:23 INFO - ##### 02:14:23 INFO - ##### Running run-tests step. 02:14:23 INFO - ##### 02:14:23 INFO - Running pre-action listener: _resource_record_pre_action 02:14:23 INFO - Running main action method: run_tests 02:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:14:23 INFO - Python 2.7.3 02:14:23 INFO - Return code: 0 02:14:23 INFO - grabbing minidump binary from tooltool 02:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:14:23 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 0x24cb410>, '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 0x24cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:14:23 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 02:14:23 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 02:14:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:14:23 INFO - Return code: 0 02:14:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:14:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:14:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:14:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:14:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:14:24 INFO - Return code: 0 02:14:24 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/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 02:14:24 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/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 02:14:24 INFO - Using env: {'DISPLAY': ':0', 02:14:24 INFO - 'HOME': '/home/cltbld', 02:14:24 INFO - 'LANG': 'en_US.UTF-8', 02:14:24 INFO - 'LANGUAGE': 'en_US:en', 02:14:24 INFO - 'LOGNAME': 'cltbld', 02:14:24 INFO - 'MAIL': '/var/mail/cltbld', 02:14:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:14:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:24 INFO - 'MOZ_NO_REMOTE': '1', 02:14:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:14:24 INFO - 'NO_EM_RESTART': '1', 02:14:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:24 INFO - 'PWD': '/builds/slave/test', 02:14:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:14:24 INFO - 'SHELL': '/bin/bash', 02:14:24 INFO - 'SHLVL': '1', 02:14:24 INFO - 'TERM': 'linux', 02:14:24 INFO - 'TMOUT': '86400', 02:14:24 INFO - 'USER': 'cltbld', 02:14:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923', 02:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:24 INFO - '_': '/tools/buildbot/bin/python'} 02:14:24 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/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 02:14:24 INFO - mozversion application_buildid: 20160401011656 02:14:24 INFO - mozversion application_changeset: 712a70746d183ee33e00bc06efd48de25b7332a7 02:14:24 INFO - mozversion application_display_name: Nightly 02:14:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:14:24 INFO - mozversion application_name: Firefox 02:14:24 INFO - mozversion application_remotingname: firefox 02:14:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:14:24 INFO - mozversion application_vendor: Mozilla 02:14:24 INFO - mozversion application_version: 48.0a1 02:14:24 INFO - mozversion platform_buildid: 20160401011656 02:14:24 INFO - mozversion platform_changeset: 712a70746d183ee33e00bc06efd48de25b7332a7 02:14:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:14:24 INFO - mozversion platform_version: 48.0a1 02:14:24 INFO - using testdate: 1459502064 02:14:24 INFO - actual date: 1459502064 02:14:24 INFO - starting webserver on 'localhost:45935' 02:14:24 INFO - SUITE-START | Running 2 tests 02:14:24 INFO - TEST-START | dromaeo_css 02:14:24 INFO - operating with platform_type : linux_ 02:14:24 INFO - Initialising browser for dromaeo_css test... 02:14:24 INFO - TEST-INFO | started process 9833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqthx70/profile http://localhost:45935/getInfo.html) 02:14:29 INFO - PROCESS | 9833 | __metrics Screen width/height:1600/1200 02:14:29 INFO - PROCESS | 9833 | colorDepth:24 02:14:29 INFO - PROCESS | 9833 | Browser inner width/height: 1024/697 02:14:29 INFO - PROCESS | 9833 | __metrics 02:14:30 ERROR - PROCESS | 9833 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:14:31 INFO - TEST-INFO | 9833: exit 0 02:14:31 INFO - Browser initialized. 02:14:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:14:31 INFO - TEST-INFO | started process 9932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqthx70/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:43 INFO - PROCESS | 9932 | RSS: Main: 155000832 02:14:43 INFO - PROCESS | 9932 | 02:15:33 INFO - PROCESS | 9932 | 1459502133978 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] 02:17:45 INFO - PROCESS | 9932 | Cycle 1(1): loaded http://localhost:45935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45935/tests/dromaeo/cssquery-ext.html) 02:17:46 INFO - PROCESS | 9932 | RSS: Main: 241745920 02:17:46 INFO - PROCESS | 9932 | 02:20:48 INFO - PROCESS | 9932 | Cycle 1(1): loaded http://localhost:45935/tests/dromaeo/cssquery-ext.html (next: http://localhost:45935/tests/dromaeo/cssquery-jquery.html) 02:20:48 INFO - PROCESS | 9932 | RSS: Main: 236355584 02:20:48 INFO - PROCESS | 9932 | 02:23:50 INFO - PROCESS | 9932 | Cycle 1(1): loaded http://localhost:45935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45935/tests/dromaeo/cssquery-mootools.html) 02:23:51 INFO - PROCESS | 9932 | RSS: Main: 233431040 02:23:51 INFO - PROCESS | 9932 | 02:26:53 INFO - PROCESS | 9932 | Cycle 1(1): loaded http://localhost:45935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45935/tests/dromaeo/cssquery-prototype.html) 02:26:53 INFO - PROCESS | 9932 | RSS: Main: 202539008 02:26:53 INFO - PROCESS | 9932 | 02:29:56 INFO - PROCESS | 9932 | Cycle 1(1): loaded http://localhost:45935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45935/tests/dromaeo/cssquery-yui.html) 02:29:57 INFO - PROCESS | 9932 | RSS: Main: 200237056 02:29:57 INFO - PROCESS | 9932 | 02:32:59 INFO - PROCESS | 9932 | Cycle 1(1): loaded http://localhost:45935/tests/dromaeo/cssquery-yui.html (next: http://localhost:45935/tests/dromaeo/cssquery-dojo.html) 02:33:00 INFO - PROCESS | 9932 | RSS: Main: 289832960 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | __start_tp_report 02:33:00 INFO - PROCESS | 9932 | _x_x_mozilla_page_load 02:33:00 INFO - PROCESS | 9932 | _x_x_mozilla_page_load_details 02:33:00 INFO - PROCESS | 9932 | |i|pagename|runs| 02:33:00 INFO - PROCESS | 9932 | |0;dojo.html;2531.911383101591;2601.661783968084;2624.160268714012;2628.9868550657243;2637.934051648709;4462.397576327195;4543.954560454395;4625.144348295564;4625.606823420009;4660.533946605342;4554.635629149669;4566.063956888838;4611.584957353837;4663.976680116603;4666.253399456088;4212.68404869636;4225.915481690365;4245.066085461209;4282.7858607069675;4337.240982827992;4245;4301.8064187111495;4315;4324.22164010478;4353.542877997812;4142.17156568686;4179.059711564904;4223.113146239293;4246.4691913510815;4262.65898728101;4181.811818468146;4225.957740422587;4227.154569086164;4257.957420425818;4281.636060934824;4088.100617864095;4222.218889505451;4224.577542245782;4232.153569286155;4273.636740877029;4471.374007638933;4521.909561808746;4521.909561808779;4546.727196368195;4553.339765733983;4930.827421040246;4935.925961110586;4952.504749525055;4957.380327459067;5004.374453193351;4746.074515469485;4906.092372910987;4943.307936888802;4947.084789313988;4979.651424400294;4611.077784443125;4662.277347011219;4671.602913752336;4707.693999889996;4709.411323584552;5056.292119103328;5076.670016448919;5080.618953578422;5083.771230294646;5124;4709;4765.809367625326;4850.393700787402;4867.221244600847;4911.705297682151;4930.2851086592245;4940.8764780880765;4948.233023881304;4949.554540091409;4954.5540901319055;4910.705357678551;4911.214205727067;4912.38595175603;4914.606831453547;4935.3090567320605;4754.7147171169845;4839.733814640158;4936.062148191832;4942.5057494251005;4952.281919121707;4164.875053748392;4170.145120250341;4171.311733563989;4172.728772629769;4195.91608167835;3655.323765103464;3660.103274697716;3676.117731744362;3683.1344634010984;3699.056740531147;4158.168366326747;4207.368894665825;4224.049588842486;4236.4492615959725;4303.720258183208;4945.975270123627;4991.600671946236;4992.375953005874;4993.825216117419;5015.949840501621;4223.387608796707;4255.021345090647;4258.148370325947;4258.233517966733;4297.935530966975;4390.714603550823;4415.161119387306;4452.220861349251;4476.104779044204;4499.055198408306;4551.431071116111;4591.334256532851;4605.493395726535;4608.815647374067;4629.629629629621;4775.689580177277;4920.40955085392;4920.7140720056705;4934.629902757236;4964.35463389757;4578.679492435497;4637.814487420465;4652.744099074584;4676.181668208118;4698.671093023456;4838.548834240676;4859.052484765437;4874.195757699939;4881.560659540658;4927.334809800631;4690.507496712796;4885.8045678172475;4918.0901533216465;4947.876303092451;4985.775640096132;4822.469528351949;4831.275308703582;4840.685355451885;4840.854774356775;4881.585065269492;4833.178359678934;4834.178189707688;4836.177849765619;4837.105135549935;4870.512948705243;4601.608863246528;4700.083483720641;4779.856604301876;4797.9040419192115;4802.159622066194;4771.093492236464;4789.425268967746;4793.304970779287;4832.468428472936;4835.564799168092;4669.673122881366;4673.088747694303;4679.2279273920785;4683.812647494062;4716.410448693913 02:33:00 INFO - PROCESS | 9932 | |1;ext.html;508.81173965632723;520.4483247757378;533.9439358867319;535.7535533654519;550.5513006899378;26693.06574269901;27237.727622723767;27261.727382726192;34732.30535389291;34747.47878781814;37305.06737331568;37705.622943770555;37882;37899;37920.620793792055;7504.212057733927;7709.267619576131;7716.807079822993;7717.112532058801;7718.073831140271;7542.547447153161;7680.500767450098;7681.23187681233;7682.654280557388;7683.3853291736805;7787.104482984472;7788.532688038707;7871.488353257048;7875.2518510741675;7877.8030549236155;7673.501222420525;7730.729424470144;7739.071311442606;7750.186230445778;7752.379809615217;7637.350825179867;7791.259830316111;7809.648565814552;7810.1799311072655;7810.375169986388;37335;38063.429048564016;38071.23857522834;38137.61862381396;38143.23713525742;2804.17276903314;2846.146156153146;2985.626796650419;3000.609920710294;3434.158631135363;27988.300292492648;28111.437771244462;28610.427791444054;29617.851910740523;29654;3275.950860737091;3308.354870800195;3317.1209629448217;3362.5964884213804;3413.35146322198;236542;270230;277277;277588.61205694044;277779;56754.14868776972;57294;57451.42548574461;57695.42304576984;57796;62054;62428.68785656043;62440.37559624346;62473.68763156246;63665;12763.29801860888;12848.807267890988;12873.485060597472;12882.162659427107;12897.097203195874;10062.849057264148;10141.087302142694;10146.13757830578;10148.543315550818;10148.644797432054;19243.808852509403;19866.801331986495;20058.498537536678;20089.296874609317;20152.193912243638;7423.85152296951;7455.88161775738;7505.924940750632;7532;7740.071191457061;916.2532535983153;922.4880191493785;955.8948515663271;972.2076507646245;1041.8280983637767;27072.729272707416;27224.183274501796;27415.588766168523;27678;27693.723062769517;877.9736607901773;884.1379654836611;895.9776005599782;929.3773171974793;944.9952750236205;14143.00998930065;14357.64105897361;14519.78220326696;14615.488457903923;15747.527574172793;373466;380117;380521;380530;380919;50900.745496272284;51364.22953655698;51475;51511;51561.48438515642;1052.2634156090614;1204.2714157934324;1209.9637010889687;1236.116176933479;1247.3326770178094;25976.48047039011;27565.17304480869;27829.582556262078;27915.860420697765;27951.58072628953;38957.6104238954;39553.80223098866;39915.201695965334;39927.80036099801;39938.60061399349;198185;203697;203890;203964;204476;27703.722962770113;31432.685673142976;31790.52314215335;31875.840620797677;32186.517202241517;37723.81138094292;38767.22465550729;39161.60838391694;39207;39570.40644390394;30778.38443231078;31090;31199;31602.683973159976;31738.20654483564;34965.825170875;35567.64432355644;35616;35841;36056.819715901256;34843;35035.64964350324;35455.82272088623;35578;35830.82084589561;31125.377492450476;32023.519647205776;32227.677723223405;32286.35427291488;32315.51526727148;24853.875730621232;24901;24963.75036249687;25235.74764252334;25302.367440813392 02:33:00 INFO - PROCESS | 9932 | |2;jquery.html;338.82934461435735;355.91991801844586;356.11505409058486;364.5188351376181;367.3938002296211;15540.378384864605;15857.524274271762;15888.443904463345;16493.17534123295;16918.238679259433;15480.845191548082;15554.84445155548;16270.26783794729;16273.674526509463;16311.184440777974;4894.339264199323;4895;5078.59371250301;5095.184770436731;5099.7705103270255;5032.82385116521;5034.84895453137;5060.089183946888;5082.974585127069;5086.694798312114;4874.173773587734;5019.247112933052;5037.4458809530925;5049.368828896388;5051.520105589963;4941.728204948727;4965.776540055688;4980.352554167935;4991.151504244251;5008.373953255843;4451.866444006685;4481.170983368087;4484.887877803081;4488.506264310923;4489.59593636571;18199.45401637953;19222.61554768897;19356.90321548383;19372;19393.612127757508;1868.7944326124116;1876.5777700017386;1918.098493707955;1944.1542928826007;2034.257496013959;8724.345674074406;9135.862962055575;12471.812922806164;12533.623991280276;12903.419346129447;1722.9569260768455;1739.339051160551;1772.645470905824;1795.64087182564;1801.5876553114135;44051.77974110141;54442.45557544453;55705.44294557084;55930.720346398004;63008.36991630071;9154.771130721652;9214;9250.814983700287;9322.813543729088;9335.579898904565;12863.614091577268;12919.289439080942;12923.612291631267;12947.611571652866;12955.5465558705;5944.346121926585;6479.514036447191;6742.292059333798;6776.593404395752;6804.693788779417;6398.200224971879;6430.228372595318;6456.128422662974;6543.378379053982;6562.114114594564;3880.3985382265796;3939.212157568498;3960.861369852099;4057.3711074783455;4137.338025915899;1568.9450869219522;1611.9113448760197;1633.7141000325134;1637.6806522727954;1710.2560386232028;845.8942632170979;884;937.1191080384417;956.7799406136488;1003.8494225866033;14931.626709332137;15039.774403383957;15054.548363549111;15142.470013549473;15466;857.562643052048;868.86966954956;871.3769654696922;873.6461732998146;879.1691851200554;9168.724938251864;9174.266058715286;9223.907760922304;9273.536323183815;9435;373122;378851;381787;384213;398319;66612;67106.32893671098;67244.6637766808;67469.66265168643;67551.3244867545;822.2928281677753;882.5631312500353;911.6991392840347;937.639008981547;940.6566603189787;14608.853911461174;14618.561443156723;14687.339069741674;14748.115113093249;15010.249487525798;32215.355692885543;33184.834075829465;33289.167770804954;33326.50010249897;33867;44214;44269.55730442654;44291.77854110709;45051.549484504736;45430.54569454395;6635.6350400728425;6720.663966801738;6762.594244345355;6812.829679258059;7132.322429369202;8359.58202089881;11280;11657.475413606238;11736.471858766547;11792.587259445878;10185.9490702546;10270.33242839213;10497.842532362174;10565.20760942917;10723.624673136403;9902.306838521234;9906.306558540833;10019.248556358449;10217.74455638615;10494.790104198026;10073.949630252095;10169.542370593488;10277.9486102569;10383.486119626896;10549.156067514426;7231.310044540342;7348.96325518369;7391.667374968247;7413.036305280495;7444;9508.952455237679;9716.659916902874;9738.610455581698;9920.206383489447;10000.59997600117 02:33:00 INFO - PROCESS | 9932 | |3;mootools.html;1287.1826390242193;1340.5509154433264;1368.9041767076303;1498.5054931872482;1801.2524802207076;6772.796816095519;7374.078240219973;7505.512141710785;7525.360344370735;7532.983047288614;7435.702571897131;7641.2358764123555;7652.081750189985;7655.119661238959;7660.195679453661;1909;2228.264672658027;2229.2754854672257;2261.2876943762744;2282.863028218304;2235.8993845277;2245.393743689203;2249.752527222004;2250.504888924434;2250.583642026222;2144.731908511436;2229.665550167472;2230.587341341849;2234.0616940884865;2237.44063984004;2198.230619283254;2216.8115710164657;2227.6881236626887;2263;2267.2064777327887;2197.318831162329;2215.8892055397164;2228.476308067603;2234.162189179058;2252.0203711385434;7702.191269916634;7780.533168009937;7780.766577002699;7788.571628560427;7792.4155688323035;4306.590873866978;4456.844010459651;4458.866234012985;4459.643228541709;4460.598546130864;2777.9305517362227;2820.4500122476124;2893.6816950135467;2944.4994350960174;2950.454165979301;917.9127982841619;932.5197523275518;941.825762233982;985.7979114281627;989.4607438945792;10379.273450858518;10389.688309350731;10403.219758518066;10421.114205292559;10424.374537527698;4182.142660754538;4217.768022758778;4290.914181716348;4304.074623955802;4339.023719663113;8922.910770892338;8926.330525210506;8960.32797540174;8961.955190224138;8977.28181745472;3945;4439.156560253541;4480;4485.6860019798305;4486.865394038184;3953.2291203215673;3981.9203615927518;3998.540167880673;4030.7581545107387;4038.414429907647;3580.3197392495345;3661.0847288177956;3674.7427680062674;3696.4085746281003;3719.20037192005;1176.670532250971;1177.1936223686803;1184.6268425445958;1195.9701007474882;1215.3558613934629;940.2055263302499;940.47333493244;948.3551185193996;978.471625322318;1203.9939800301117;7185.712571497186;7186.245444228281;7223.349898509159;7249.601271930094;7256.528325658815;455.39659950565635;463.87707257576767;483.1713611156883;484.1551492645356;484.84727310896955;5445.455454454523;5548.55611551083;5616.831495055155;5621.0444224481935;5641.323041235078;8632.91367086321;8858.601362938683;8867.645294188289;8872.467651940904;8873.467591944504;8730.69442569507;8743.781405464913;8744.562771861381;8752.956235218911;8764.079771623889;6460.257070436866;6589.110470086573;6650.035744816974;6699.564528305645;6708.228553716288;6484.059811327425;6525.804225873231;6529.183852018497;6535;6536.346365363425;7576.696932122653;7745.457817952914;7874.842503150019;7895.68417263303;7921.089074756477;7833.373330133461;8009.879851802344;8014.078380986261;8141.755747327589;8145.877811832709;6270.404311590391;6337.176167098432;6402.679866006588;6425.389587989133;6426.260979987362;6690.632015239208;6699.19609646826;6723.327667233238;6729.831754206184;6754.763583274562;6187.412195841388;6361.586496877688;6388.329225431263;6429.678516074271;6439.7424103035355;6303.338149494237;6323.7786677466065;6344.492440604833;6429.678516074271;6473.773417930538;6807.523473357016;6819.556728812611;6824.727010919508;6987.650617469005;7001.684924178322;6004.609700369462;6178.969105154445;6234.688265586612;6243.500519958302;6245.094461302995;6398.71205795731;6404.327545607644;6427.292997770148;6436.903446448214;6443.065755465525 02:33:00 INFO - PROCESS | 9932 | |4;prototype.html;310.72811290121143;312.47504192955824;320.8203406092589;321.5085258932709;322.74503142517426;5268.288781014567;5349.117395629726;5380.704061276633;5383.730813459331;5398.757055932482;5290.973545132269;5292.126799078157;5307.336582927134;5311.707856067925;5323.307969963899;3902.1025164212247;4019.9598004019876;4156.2934301168725;4159;4161.3549899765585;4168.7707176105305;4193.937090943638;4194.748315101088;4203.5376108628025;4210.62104410603;4154.335306350985;4155.605217504332;4156.667466602679;4160.54234034256;4167.166566686659;3932.9410058849;4002.1795531916177;4011.5587285398583;4045.8786236412957;4161.667066634662;3555.9111022224392;3610.151614370621;3618.493410922473;3618.710503159767;3622.7826330419994;5071.264666623356;5097.082525145473;5104.515071068243;5106.519109458252;5117;4781.330613714048;4782.641301902371;4783.449903261135;4792.544708252711;4804.471508134103;5605.775768969236;5606.635568688022;5608.971955140199;5610.49505544503;5621.747021384048;4021;4024.7383920045104;4024.839006439739;4026.778527181004;4028.033272014725;5729.312482502085;5909.674967876765;5912.231409916726;5943.375945525744;5961.076033214858;3991.84032638697;4007.5992400760274;4020.778857162884;4028.637422631977;4031.637152656275;4076.612721791425;4079.9592004079577;4083.1833633273463;4086.203190377907;4086.9386959195635;4714.834980775657;4715.74063426508;4721.834735784231;4722.905541889212;4725.054989002213;5658.603897727119;5660.603757737002;5670.489655930986;5671.262735844314;5674.517665998436;1408.7112142010862;1433.749093908562;1437.3172742947017;1438.8345340285791;1439.6185010972101;936.6768464879606;948.2840455456087;959.5346257065318;965.971020869375;967.56943160293;4721.929171062437;4791.544803243686;4857.028594281158;4870.95129048705;4928.211486162269;5887.411258874078;5902.527797776168;5910.556708246899;5915;5917.437843404869;4922.803087876517;4937.987712518925;4938.506149385104;4946.975265123651;4948.480409556944;3133.7022982816598;3165.7309128723855;3167.445697003015;3171.0645359618966;3172.5406313095773;5441.483059109379;5448.073827449343;5458.863528411822;5475.7262136893;5476.26070480488;5842.8539286517325;6022.18700475439;6033.698315084228;6043.7280322385595;6046.304674962347;5423.810166644149;5446.21029950655;5447.673139611636;5447.836564903059;5453.3455985281225;5799.333076696065;5863.589548731547;5864.853378665567;5885.14665373527;5885.176075349369;5728.398518155534;5752.0509115997065;5755.5971082025535;5769.307683078057;5778;5436;5439.646422982493;5451.100568406168;5454.336427389526;5454.645448045864;3897.805109744558;4002.9599704003754;4017.578154293757;4027.8993025174605;4029.536603290659;5817.981853175762;5840;5855.619384739978;5858.384869588632;5867.6772777497645;5661.433856614306;5669.433056694297;5673.546116310603;5679.091345384719;5680.233168522362;5602.607817452902;5623.831285061455;5652.463016013472;5663.631863928831;5664.461876121762;5570.86072848182;5582;5587.636803607753;5590.44095590454;5593.412691667317;5506.779728810803;5698.8290351289525;5705.885882282248;5709.800156994485;5710.8001219957105;5499.450054994469;5528.115501519737;5532.889342213052;5533.3083364579425;5535.916961245665 02:33:00 INFO - PROCESS | 9932 | |5;yui.html;631.2015300644683;655.2661019657983;744.7170075371358;749.4866016778507;753.4800987318746;11494.885051149486;11627.941860290686;11685.240459370136;11692.29846209228;11702.882971170297;12113;12177.878221217785;13643.113197642171;14060.296985150753;14087.506937257198;802.9317508011811;814.4543156085437;815.2011029191395;816.4611356504709;816.9714060007901;530.9893802123955;547.7535109200855;548.1531034551627;548.6077454619946;641.1952998986266;847.6397531049311;849.7875531117221;850.4599579267148;851.1403482482675;852.2287329966359;664.8504086580529;846.3779122345071;848.3594885861166;848.7878030492377;849.2399302624148;608.5101493297893;615.1725928625991;616.140484024783;616.1774031667729;616.2266355723583;11678.357690327028;11763;11784.175107742376;11792.23350482216;11804.11469139818;11609.6517104487;11619.883801161965;12012.69968250792;12110.878891211063;12557;9667.178289845371;9715.174210192143;9806.607735690564;9841.704748857546;9908.851367229498;3178.300773829754;3214.5660335854595;3247.951280730791;3269.73842092632;3271.509273608954;43127.353089703676;43259.78370108161;43358.56641433577;43538.12923741507;43841.78079109616;8706.507093603863;8827.07315731839;8885.511296878734;9151.77120571991;9166.49584272858;16087.758683619755;16219.756703649455;16220.188990550425;16376;16869;6285.214348206474;6296.464800491918;6322.114903913456;6403.359664033653;6428.485721142298;3611.620779818134;3660.7857465984684;3698.9445158322646;3725.590185079639;3742.3450896093077;2827.067067867599;2842.971570284312;2863.8568071596337;2870.1963450233966;2877.4676684813376;507.1631807517552;519.5947161214259;525.7134861500415;530.9946900531022;532;559.2561892682722;578.2453897663505;584.5791030458064;590;598.0938877600439;7321.194668586451;7389.963050184715;7429.07136607924;7572.4699271051595;7671.53970761756;485.6624645871156;491.48885159433786;537.7848860455771;540.9675419474844;552.4558310064583;3383.120388698956;3447.052060683282;3465.428204346305;3516.82415879205;3528.3119791640897;46915.5308446918;48272.27591586129;48446.5155348442;48942.02115957661;49075.75462122667;40894.79552602218;40957.79521102375;41108.38337424941;41121;41603.37594936079;39299.410508842964;39349.40975885364;39631.40552891709;40110.19779604392;40251.79874100611;8081.595920204084;8158.632861521364;8187.631556579849;8296.502209867427;8396.118407567117;31073.68926310708;31141.8442907784;31357.372852542365;31510.842445787624;32219.35561288808;35525.644743552235;35570.11074723153;36213.456798148574;38316;38318.616813831504;9910.35582687123;10139.608341735044;10150.086492215736;10289.382637041503;10533.525991330562;10956.671299861016;10957.232993690364;10972.780544388908;10974.561017559208;11035.613753518588;10442.738931526468;10445.164386848883;10758;11083.833742493707;11088;9915.107640312119;10212.897871021194;10240.897591024292;10287.742806429898;10312.123469505175;10564.181368244555;10773.51519181623;11047.613333533287;11064.170187235828;11114.944425277821;7529.171791103084;8302.381035697981;9312.813743725223;9544.141027307576;9545.570449329936;8670.869936951078;8728.65085396577;9149.63401463934;9218.21645160169;9273.814523709623 02:33:00 INFO - PROCESS | 9932 | __end_tp_report 02:33:00 INFO - PROCESS | 9932 | __start_cc_report 02:33:00 INFO - PROCESS | 9932 | _x_x_mozilla_cycle_collect,857 02:33:00 INFO - PROCESS | 9932 | __end_cc_report 02:33:00 INFO - PROCESS | 9932 | __startTimestamp1459503180041__endTimestamp 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | ------- Summary: start ------- 02:33:00 INFO - PROCESS | 9932 | Number of tests: 6 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | [#0] dojo.html Cycles:165 Average:4555.21 Median:4671.60 stddev:473.18 (10.1%) stddev-sans-first:447.22 02:33:00 INFO - PROCESS | 9932 | Values: 2531.9 2601.7 2624.2 2629.0 2637.9 4462.4 4544.0 4625.1 4625.6 4660.5 4554.6 4566.1 4611.6 4664.0 4666.3 4212.7 4225.9 4245.1 4282.8 4337.2 4245.0 4301.8 4315.0 4324.2 4353.5 4142.2 4179.1 4223.1 4246.5 4262.7 4181.8 4226.0 4227.2 4258.0 4281.6 4088.1 4222.2 4224.6 4232.2 4273.6 4471.4 4521.9 4521.9 4546.7 4553.3 4930.8 4935.9 4952.5 4957.4 5004.4 4746.1 4906.1 4943.3 4947.1 4979.7 4611.1 4662.3 4671.6 4707.7 4709.4 5056.3 5076.7 5080.6 5083.8 5124.0 4709.0 4765.8 4850.4 4867.2 4911.7 4930.3 4940.9 4948.2 4949.6 4954.6 4910.7 4911.2 4912.4 4914.6 4935.3 4754.7 4839.7 4936.1 4942.5 4952.3 4164.9 4170.1 4171.3 4172.7 4195.9 3655.3 3660.1 3676.1 3683.1 3699.1 4158.2 4207.4 4224.0 4236.4 4303.7 4946.0 4991.6 4992.4 4993.8 5015.9 4223.4 4255.0 4258.1 4258.2 4297.9 4390.7 4415.2 4452.2 4476.1 4499.1 4551.4 4591.3 4605.5 4608.8 4629.6 4775.7 4920.4 4920.7 4934.6 4964.4 4578.7 4637.8 4652.7 4676.2 4698.7 4838.5 4859.1 4874.2 4881.6 4927.3 4690.5 4885.8 4918.1 4947.9 4985.8 4822.5 4831.3 4840.7 4840.9 4881.6 4833.2 4834.2 4836.2 4837.1 4870.5 4601.6 4700.1 4779.9 4797.9 4802.2 4771.1 4789.4 4793.3 4832.5 4835.6 4669.7 4673.1 4679.2 4683.8 4716.4 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | [#1] ext.html Cycles:180 Average:44255.70 Median:35572.82 stddev:77102.14 (216.7%) stddev-sans-first:77248.47 02:33:00 INFO - PROCESS | 9932 | Values: 508.8 520.4 533.9 535.8 550.6 26693.1 27237.7 27261.7 34732.3 34747.5 37305.1 37705.6 37882.0 37899.0 37920.6 7504.2 7709.3 7716.8 7717.1 7718.1 7542.5 7680.5 7681.2 7682.7 7683.4 7787.1 7788.5 7871.5 7875.3 7877.8 7673.5 7730.7 7739.1 7750.2 7752.4 7637.4 7791.3 7809.6 7810.2 7810.4 37335.0 38063.4 38071.2 38137.6 38143.2 2804.2 2846.1 2985.6 3000.6 3434.2 27988.3 28111.4 28610.4 29617.9 29654.0 3276.0 3308.4 3317.1 3362.6 3413.4 236542.0 270230.0 277277.0 277588.6 277779.0 56754.1 57294.0 57451.4 57695.4 57796.0 62054.0 62428.7 62440.4 62473.7 63665.0 12763.3 12848.8 12873.5 12882.2 12897.1 10062.8 10141.1 10146.1 10148.5 10148.6 19243.8 19866.8 20058.5 20089.3 20152.2 7423.9 7455.9 7505.9 7532.0 7740.1 916.3 922.5 955.9 972.2 1041.8 27072.7 27224.2 27415.6 27678.0 27693.7 878.0 884.1 896.0 929.4 945.0 14143.0 14357.6 14519.8 14615.5 15747.5 373466.0 380117.0 380521.0 380530.0 380919.0 50900.7 51364.2 51475.0 51511.0 51561.5 1052.3 1204.3 1210.0 1236.1 1247.3 25976.5 27565.2 27829.6 27915.9 27951.6 38957.6 39553.8 39915.2 39927.8 39938.6 198185.0 203697.0 203890.0 203964.0 204476.0 27703.7 31432.7 31790.5 31875.8 32186.5 37723.8 38767.2 39161.6 39207.0 39570.4 30778.4 31090.0 31199.0 31602.7 31738.2 34965.8 35567.6 35616.0 35841.0 36056.8 34843.0 35035.6 35455.8 35578.0 35830.8 31125.4 32023.5 32227.7 32286.4 32315.5 24853.9 24901.0 24963.8 25235.7 25302.4 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | [#2] jquery.html Cycles:180 Average:22841.39 Median:24371.82 stddev:62862.30 (257.9%) stddev-sans-first:63015.94 02:33:00 INFO - PROCESS | 9932 | Values: 338.8 355.9 356.1 364.5 367.4 15540.4 15857.5 15888.4 16493.2 16918.2 15480.8 15554.8 16270.3 16273.7 16311.2 4894.3 4895.0 5078.6 5095.2 5099.8 5032.8 5034.8 5060.1 5083.0 5086.7 4874.2 5019.2 5037.4 5049.4 5051.5 4941.7 4965.8 4980.4 4991.2 5008.4 4451.9 4481.2 4484.9 4488.5 4489.6 18199.5 19222.6 19356.9 19372.0 19393.6 1868.8 1876.6 1918.1 1944.2 2034.3 8724.3 9135.9 12471.8 12533.6 12903.4 1723.0 1739.3 1772.6 1795.6 1801.6 44051.8 54442.5 55705.4 55930.7 63008.4 9154.8 9214.0 9250.8 9322.8 9335.6 12863.6 12919.3 12923.6 12947.6 12955.5 5944.3 6479.5 6742.3 6776.6 6804.7 6398.2 6430.2 6456.1 6543.4 6562.1 3880.4 3939.2 3960.9 4057.4 4137.3 1568.9 1611.9 1633.7 1637.7 1710.3 845.9 884.0 937.1 956.8 1003.8 14931.6 15039.8 15054.5 15142.5 15466.0 857.6 868.9 871.4 873.6 879.2 9168.7 9174.3 9223.9 9273.5 9435.0 373122.0 378851.0 381787.0 384213.0 398319.0 66612.0 67106.3 67244.7 67469.7 67551.3 822.3 882.6 911.7 937.6 940.7 14608.9 14618.6 14687.3 14748.1 15010.2 32215.4 33184.8 33289.2 33326.5 33867.0 44214.0 44269.6 44291.8 45051.5 45430.5 6635.6 6720.7 6762.6 6812.8 7132.3 8359.6 11280.0 11657.5 11736.5 11792.6 10185.9 10270.3 10497.8 10565.2 10723.6 9902.3 9906.3 10019.2 10217.7 10494.8 10073.9 10169.5 10277.9 10383.5 10549.2 7231.3 7349.0 7391.7 7413.0 7444.0 9509.0 9716.7 9738.6 9920.2 10000.6 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | [#3] mootools.html Cycles:180 Average:5181.16 Median:6340.83 stddev:2707.27 (42.7%) stddev-sans-first:2699.04 02:33:00 INFO - PROCESS | 9932 | Values: 1287.2 1340.6 1368.9 1498.5 1801.3 6772.8 7374.1 7505.5 7525.4 7533.0 7435.7 7641.2 7652.1 7655.1 7660.2 1909.0 2228.3 2229.3 2261.3 2282.9 2235.9 2245.4 2249.8 2250.5 2250.6 2144.7 2229.7 2230.6 2234.1 2237.4 2198.2 2216.8 2227.7 2263.0 2267.2 2197.3 2215.9 2228.5 2234.2 2252.0 7702.2 7780.5 7780.8 7788.6 7792.4 4306.6 4456.8 4458.9 4459.6 4460.6 2777.9 2820.5 2893.7 2944.5 2950.5 917.9 932.5 941.8 985.8 989.5 10379.3 10389.7 10403.2 10421.1 10424.4 4182.1 4217.8 4290.9 4304.1 4339.0 8922.9 8926.3 8960.3 8962.0 8977.3 3945.0 4439.2 4480.0 4485.7 4486.9 3953.2 3981.9 3998.5 4030.8 4038.4 3580.3 3661.1 3674.7 3696.4 3719.2 1176.7 1177.2 1184.6 1196.0 1215.4 940.2 940.5 948.4 978.5 1204.0 7185.7 7186.2 7223.3 7249.6 7256.5 455.4 463.9 483.2 484.2 484.8 5445.5 5548.6 5616.8 5621.0 5641.3 8632.9 8858.6 8867.6 8872.5 8873.5 8730.7 8743.8 8744.6 8753.0 8764.1 6460.3 6589.1 6650.0 6699.6 6708.2 6484.1 6525.8 6529.2 6535.0 6536.3 7576.7 7745.5 7874.8 7895.7 7921.1 7833.4 8009.9 8014.1 8141.8 8145.9 6270.4 6337.2 6402.7 6425.4 6426.3 6690.6 6699.2 6723.3 6729.8 6754.8 6187.4 6361.6 6388.3 6429.7 6439.7 6303.3 6323.8 6344.5 6429.7 6473.8 6807.5 6819.6 6824.7 6987.7 7001.7 6004.6 6179.0 6234.7 6243.5 6245.1 6398.7 6404.3 6427.3 6436.9 6443.1 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | [#4] prototype.html Cycles:180 Average:4668.81 Median:5336.21 stddev:1375.48 (25.8%) stddev-sans-first:1339.88 02:33:00 INFO - PROCESS | 9932 | Values: 310.7 312.5 320.8 321.5 322.7 5268.3 5349.1 5380.7 5383.7 5398.8 5291.0 5292.1 5307.3 5311.7 5323.3 3902.1 4020.0 4156.3 4159.0 4161.4 4168.8 4193.9 4194.7 4203.5 4210.6 4154.3 4155.6 4156.7 4160.5 4167.2 3932.9 4002.2 4011.6 4045.9 4161.7 3555.9 3610.2 3618.5 3618.7 3622.8 5071.3 5097.1 5104.5 5106.5 5117.0 4781.3 4782.6 4783.4 4792.5 4804.5 5605.8 5606.6 5609.0 5610.5 5621.7 4021.0 4024.7 4024.8 4026.8 4028.0 5729.3 5909.7 5912.2 5943.4 5961.1 3991.8 4007.6 4020.8 4028.6 4031.6 4076.6 4080.0 4083.2 4086.2 4086.9 4714.8 4715.7 4721.8 4722.9 4725.1 5658.6 5660.6 5670.5 5671.3 5674.5 1408.7 1433.7 1437.3 1438.8 1439.6 936.7 948.3 959.5 966.0 967.6 4721.9 4791.5 4857.0 4871.0 4928.2 5887.4 5902.5 5910.6 5915.0 5917.4 4922.8 4938.0 4938.5 4947.0 4948.5 3133.7 3165.7 3167.4 3171.1 3172.5 5441.5 5448.1 5458.9 5475.7 5476.3 5842.9 6022.2 6033.7 6043.7 6046.3 5423.8 5446.2 5447.7 5447.8 5453.3 5799.3 5863.6 5864.9 5885.1 5885.2 5728.4 5752.1 5755.6 5769.3 5778.0 5436.0 5439.6 5451.1 5454.3 5454.6 3897.8 4003.0 4017.6 4027.9 4029.5 5818.0 5840.0 5855.6 5858.4 5867.7 5661.4 5669.4 5673.5 5679.1 5680.2 5602.6 5623.8 5652.5 5663.6 5664.5 5570.9 5582.0 5587.6 5590.4 5593.4 5506.8 5698.8 5705.9 5709.8 5710.8 5499.5 5528.1 5532.9 5533.3 5535.9 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - PROCESS | 9932 | [#5] yui.html Cycles:180 Average:12132.12 Median:43448.35 stddev:13486.86 (31.0%) stddev-sans-first:13497.04 02:33:00 INFO - PROCESS | 9932 | Values: 631.2 655.3 744.7 749.5 753.5 11494.9 11627.9 11685.2 11692.3 11702.9 12113.0 12177.9 13643.1 14060.3 14087.5 802.9 814.5 815.2 816.5 817.0 531.0 547.8 548.2 548.6 641.2 847.6 849.8 850.5 851.1 852.2 664.9 846.4 848.4 848.8 849.2 608.5 615.2 616.1 616.2 616.2 11678.4 11763.0 11784.2 11792.2 11804.1 11609.7 11619.9 12012.7 12110.9 12557.0 9667.2 9715.2 9806.6 9841.7 9908.9 3178.3 3214.6 3248.0 3269.7 3271.5 43127.4 43259.8 43358.6 43538.1 43841.8 8706.5 8827.1 8885.5 9151.8 9166.5 16087.8 16219.8 16220.2 16376.0 16869.0 6285.2 6296.5 6322.1 6403.4 6428.5 3611.6 3660.8 3698.9 3725.6 3742.3 2827.1 2843.0 2863.9 2870.2 2877.5 507.2 519.6 525.7 531.0 532.0 559.3 578.2 584.6 590.0 598.1 7321.2 7390.0 7429.1 7572.5 7671.5 485.7 491.5 537.8 541.0 552.5 3383.1 3447.1 3465.4 3516.8 3528.3 46915.5 48272.3 48446.5 48942.0 49075.8 40894.8 40957.8 41108.4 41121.0 41603.4 39299.4 39349.4 39631.4 40110.2 40251.8 8081.6 8158.6 8187.6 8296.5 8396.1 31073.7 31141.8 31357.4 31510.8 32219.4 35525.6 35570.1 36213.5 38316.0 38318.6 9910.4 10139.6 10150.1 10289.4 10533.5 10956.7 10957.2 10972.8 10974.6 11035.6 10442.7 10445.2 10758.0 11083.8 11088.0 9915.1 10212.9 10240.9 10287.7 10312.1 10564.2 10773.5 11047.6 11064.2 11114.9 7529.2 8302.4 9312.8 9544.1 9545.6 8670.9 8728.7 9149.6 9218.2 9273.8 02:33:00 INFO - PROCESS | 9932 | -------- Summary: end -------- 02:33:00 INFO - PROCESS | 9932 | 02:33:00 INFO - TEST-INFO | 9932: exit 0 02:33:00 INFO - TEST-OK | dromaeo_css | took 1115870ms 02:33:00 INFO - TEST-START | kraken 02:33:00 INFO - operating with platform_type : linux_ 02:33:00 INFO - Initialising browser for kraken test... 02:33:00 INFO - TEST-INFO | started process 10116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7ogdRu/profile http://localhost:45935/getInfo.html) 02:33:05 INFO - PROCESS | 10116 | __metrics Screen width/height:1600/1200 02:33:05 INFO - PROCESS | 10116 | colorDepth:24 02:33:05 INFO - PROCESS | 10116 | Browser inner width/height: 1024/697 02:33:05 INFO - PROCESS | 10116 | __metrics 02:33:05 ERROR - PROCESS | 10116 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:33:06 INFO - TEST-INFO | 10116: exit 0 02:33:06 INFO - Browser initialized. 02:33:06 INFO - Running cycle 1/1 for kraken test... 02:33:06 INFO - TEST-INFO | started process 10199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7ogdRu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:18 INFO - PROCESS | 10199 | RSS: Main: 155295744 02:33:18 INFO - PROCESS | 10199 | 02:33:21 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45935/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:22 INFO - PROCESS | 10199 | RSS: Main: 197599232 02:33:22 INFO - PROCESS | 10199 | 02:33:24 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45935/tests/kraken/driver.html?testName=audio-dft) 02:33:25 INFO - PROCESS | 10199 | RSS: Main: 187785216 02:33:25 INFO - PROCESS | 10199 | 02:33:28 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45935/tests/kraken/driver.html?testName=audio-fft) 02:33:28 INFO - PROCESS | 10199 | RSS: Main: 171356160 02:33:28 INFO - PROCESS | 10199 | 02:33:31 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45935/tests/kraken/driver.html?testName=audio-oscillator) 02:33:31 INFO - PROCESS | 10199 | RSS: Main: 172855296 02:33:31 INFO - PROCESS | 10199 | 02:33:33 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:34 INFO - PROCESS | 10199 | RSS: Main: 174182400 02:33:34 INFO - PROCESS | 10199 | 02:33:37 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45935/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:38 INFO - PROCESS | 10199 | RSS: Main: 174555136 02:33:38 INFO - PROCESS | 10199 | 02:33:41 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45935/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:42 INFO - PROCESS | 10199 | RSS: Main: 175448064 02:33:42 INFO - PROCESS | 10199 | 02:33:45 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45935/tests/kraken/driver.html?testName=json-parse-financial) 02:33:45 INFO - PROCESS | 10199 | RSS: Main: 174620672 02:33:45 INFO - PROCESS | 10199 | 02:33:47 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:48 INFO - PROCESS | 10199 | RSS: Main: 186638336 02:33:48 INFO - PROCESS | 10199 | 02:33:49 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:50 INFO - PROCESS | 10199 | RSS: Main: 183934976 02:33:50 INFO - PROCESS | 10199 | 02:33:52 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:53 INFO - PROCESS | 10199 | RSS: Main: 196517888 02:33:53 INFO - PROCESS | 10199 | 02:33:55 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:56 INFO - PROCESS | 10199 | RSS: Main: 199294976 02:33:56 INFO - PROCESS | 10199 | 02:33:58 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:59 INFO - PROCESS | 10199 | RSS: Main: 198574080 02:33:59 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | Cycle 1(1): loaded http://localhost:45935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45935/tests/kraken/driver.html?testName=ai-astar) 02:34:01 INFO - PROCESS | 10199 | RSS: Main: 260849664 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | __start_tp_report 02:34:01 INFO - PROCESS | 10199 | _x_x_mozilla_page_load 02:34:01 INFO - PROCESS | 10199 | _x_x_mozilla_page_load_details 02:34:01 INFO - PROCESS | 10199 | |i|pagename|runs| 02:34:01 INFO - PROCESS | 10199 | |0;ai-astar;111;111;106;111;112;113;100;111;111;110 02:34:01 INFO - PROCESS | 10199 | |1;audio-beat-detection;166;131;160;179;137;169;154;134;175;133 02:34:01 INFO - PROCESS | 10199 | |2;audio-dft;160;160;161;159;161;161;161;161;162;162 02:34:01 INFO - PROCESS | 10199 | |3;audio-fft;74;74;105;94;74;73;74;131;110;74 02:34:01 INFO - PROCESS | 10199 | |4;audio-oscillator;94;93;146;94;101;94;132;94;94;137 02:34:01 INFO - PROCESS | 10199 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;118;118 02:34:01 INFO - PROCESS | 10199 | |6;imaging-darkroom;146;147;148;146;147;146;147;147;147;148 02:34:01 INFO - PROCESS | 10199 | |7;imaging-desaturate;96;96;96;96;97;95;95;96;95;96 02:34:01 INFO - PROCESS | 10199 | |8;json-parse-financial;65;66;65;65;65;65;64;76;62;62 02:34:01 INFO - PROCESS | 10199 | |9;json-stringify-tinderbox;64;64;64;63;64;64;65;63;65;65 02:34:01 INFO - PROCESS | 10199 | |10;stanford-crypto-aes;81;82;83;83;83;81;82;82;84;83 02:34:01 INFO - PROCESS | 10199 | |11;stanford-crypto-ccm;119;115;116;118;129;121;116;128;124;118 02:34:01 INFO - PROCESS | 10199 | |12;stanford-crypto-pbkdf2;143;136;130;154;143;132;141;143;143;142 02:34:01 INFO - PROCESS | 10199 | |13;stanford-crypto-sha256-iterative;69;72;68;67;70;67;66;68;66;68 02:34:01 INFO - PROCESS | 10199 | __end_tp_report 02:34:01 INFO - PROCESS | 10199 | __start_cc_report 02:34:01 INFO - PROCESS | 10199 | _x_x_mozilla_cycle_collect,1197 02:34:01 INFO - PROCESS | 10199 | __end_cc_report 02:34:01 INFO - PROCESS | 10199 | __startTimestamp1459503241510__endTimestamp 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | ------- Summary: start ------- 02:34:01 INFO - PROCESS | 10199 | Number of tests: 14 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.84 (3.5%) stddev-sans-first:4.03 02:34:01 INFO - PROCESS | 10199 | Values: 111.0 111.0 106.0 111.0 112.0 113.0 100.0 111.0 111.0 110.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:163.00 stddev:18.65 (11.4%) stddev-sans-first:19.25 02:34:01 INFO - PROCESS | 10199 | Values: 166.0 131.0 160.0 179.0 137.0 169.0 154.0 134.0 175.0 133.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 02:34:01 INFO - PROCESS | 10199 | Values: 160.0 160.0 161.0 159.0 161.0 161.0 161.0 161.0 162.0 162.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#3] audio-fft Cycles:10 Average:88.30 Median:74.00 stddev:20.72 (28.0%) stddev-sans-first:21.32 02:34:01 INFO - PROCESS | 10199 | Values: 74.0 74.0 105.0 94.0 74.0 73.0 74.0 131.0 110.0 74.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:94.00 stddev:21.38 (22.7%) stddev-sans-first:22.08 02:34:01 INFO - PROCESS | 10199 | Values: 94.0 93.0 146.0 94.0 101.0 94.0 132.0 94.0 94.0 137.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:34:01 INFO - PROCESS | 10199 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 02:34:01 INFO - PROCESS | 10199 | Values: 146.0 147.0 148.0 146.0 147.0 146.0 147.0 147.0 147.0 148.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 02:34:01 INFO - PROCESS | 10199 | Values: 96.0 96.0 96.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.00 stddev:3.92 (6.0%) stddev-sans-first:4.16 02:34:01 INFO - PROCESS | 10199 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 64.0 76.0 62.0 62.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 02:34:01 INFO - PROCESS | 10199 | Values: 64.0 64.0 64.0 63.0 64.0 64.0 65.0 63.0 65.0 65.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:0.88 02:34:01 INFO - PROCESS | 10199 | Values: 81.0 82.0 83.0 83.0 83.0 81.0 82.0 82.0 84.0 83.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:120.00 stddev:5.02 (4.2%) stddev-sans-first:5.29 02:34:01 INFO - PROCESS | 10199 | Values: 119.0 115.0 116.0 118.0 129.0 121.0 116.0 128.0 124.0 118.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:143.00 stddev:6.77 (4.7%) stddev-sans-first:7.13 02:34:01 INFO - PROCESS | 10199 | Values: 143.0 136.0 130.0 154.0 143.0 132.0 141.0 143.0 143.0 142.0 02:34:01 INFO - PROCESS | 10199 | 02:34:01 INFO - PROCESS | 10199 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.85 (2.7%) stddev-sans-first:1.94 02:34:01 INFO - PROCESS | 10199 | Values: 69.0 72.0 68.0 67.0 70.0 67.0 66.0 68.0 66.0 68.0 02:34:01 INFO - PROCESS | 10199 | -------- Summary: end -------- 02:34:01 INFO - PROCESS | 10199 | 02:34:02 INFO - TEST-INFO | 10199: exit 0 02:34:02 INFO - TEST-OK | kraken | took 61689ms 02:34:02 INFO - SUITE-END | took 1177s 02:34:02 INFO - Completed test suite (00:19:37) 02:34:02 INFO - javascript benchmark 02:34:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2531.911383101591, 2601.661783968084, 2624.160268714012, 2628.9868550657243, 2637.934051648709, 4462.397576327195, 4543.954560454395, 4625.144348295564, 4625.606823420009, 4660.533946605342, 4554.635629149669, 4566.063956888838, 4611.584957353837, 4663.976680116603, 4666.253399456088, 4212.68404869636, 4225.915481690365, 4245.066085461209, 4282.7858607069675, 4337.240982827992, 4245.0, 4301.8064187111495, 4315.0, 4324.22164010478, 4353.542877997812, 4142.17156568686, 4179.059711564904, 4223.113146239293, 4246.4691913510815, 4262.65898728101, 4181.811818468146, 4225.957740422587, 4227.154569086164, 4257.957420425818, 4281.636060934824, 4088.100617864095, 4222.218889505451, 4224.577542245782, 4232.153569286155, 4273.636740877029, 4471.374007638933, 4521.909561808746, 4521.909561808779, 4546.727196368195, 4553.339765733983, 4930.827421040246, 4935.925961110586, 4952.504749525055, 4957.380327459067, 5004.374453193351, 4746.074515469485, 4906.092372910987, 4943.307936888802, 4947.084789313988, 4979.651424400294, 4611.077784443125, 4662.277347011219, 4671.602913752336, 4707.693999889996, 4709.411323584552, 5056.292119103328, 5076.670016448919, 5080.618953578422, 5083.771230294646, 5124.0, 4709.0, 4765.809367625326, 4850.393700787402, 4867.221244600847, 4911.705297682151, 4930.2851086592245, 4940.8764780880765, 4948.233023881304, 4949.554540091409, 4954.5540901319055, 4910.705357678551, 4911.214205727067, 4912.38595175603, 4914.606831453547, 4935.3090567320605, 4754.7147171169845, 4839.733814640158, 4936.062148191832, 4942.5057494251005, 4952.281919121707, 4164.875053748392, 4170.145120250341, 4171.311733563989, 4172.728772629769, 4195.91608167835, 3655.323765103464, 3660.103274697716, 3676.117731744362, 3683.1344634010984, 3699.056740531147, 4158.168366326747, 4207.368894665825, 4224.049588842486, 4236.4492615959725, 4303.720258183208, 4945.975270123627, 4991.600671946236, 4992.375953005874, 4993.825216117419, 5015.949840501621, 4223.387608796707, 4255.021345090647, 4258.148370325947, 4258.233517966733, 4297.935530966975, 4390.714603550823, 4415.161119387306, 4452.220861349251, 4476.104779044204, 4499.055198408306, 4551.431071116111, 4591.334256532851, 4605.493395726535, 4608.815647374067, 4629.629629629621, 4775.689580177277, 4920.40955085392, 4920.7140720056705, 4934.629902757236, 4964.35463389757, 4578.679492435497, 4637.814487420465, 4652.744099074584, 4676.181668208118, 4698.671093023456, 4838.548834240676, 4859.052484765437, 4874.195757699939, 4881.560659540658, 4927.334809800631, 4690.507496712796, 4885.8045678172475, 4918.0901533216465, 4947.876303092451, 4985.775640096132, 4822.469528351949, 4831.275308703582, 4840.685355451885, 4840.854774356775, 4881.585065269492, 4833.178359678934, 4834.178189707688, 4836.177849765619, 4837.105135549935, 4870.512948705243, 4601.608863246528, 4700.083483720641, 4779.856604301876, 4797.9040419192115, 4802.159622066194, 4771.093492236464, 4789.425268967746, 4793.304970779287, 4832.468428472936, 4835.564799168092, 4669.673122881366, 4673.088747694303, 4679.2279273920785, 4683.812647494062, 4716.410448693913], "unit": "score", "name": "dojo.html", "value": 4525.5103051840715}, {"lowerIsBetter": false, "replicates": [508.81173965632723, 520.4483247757378, 533.9439358867319, 535.7535533654519, 550.5513006899378, 26693.06574269901, 27237.727622723767, 27261.727382726192, 34732.30535389291, 34747.47878781814, 37305.06737331568, 37705.622943770555, 37882.0, 37899.0, 37920.620793792055, 7504.212057733927, 7709.267619576131, 7716.807079822993, 7717.112532058801, 7718.073831140271, 7542.547447153161, 7680.500767450098, 7681.23187681233, 7682.654280557388, 7683.3853291736805, 7787.104482984472, 7788.532688038707, 7871.488353257048, 7875.2518510741675, 7877.8030549236155, 7673.501222420525, 7730.729424470144, 7739.071311442606, 7750.186230445778, 7752.379809615217, 7637.350825179867, 7791.259830316111, 7809.648565814552, 7810.1799311072655, 7810.375169986388, 37335.0, 38063.429048564016, 38071.23857522834, 38137.61862381396, 38143.23713525742, 2804.17276903314, 2846.146156153146, 2985.626796650419, 3000.609920710294, 3434.158631135363, 27988.300292492648, 28111.437771244462, 28610.427791444054, 29617.851910740523, 29654.0, 3275.950860737091, 3308.354870800195, 3317.1209629448217, 3362.5964884213804, 3413.35146322198, 236542.0, 270230.0, 277277.0, 277588.61205694044, 277779.0, 56754.14868776972, 57294.0, 57451.42548574461, 57695.42304576984, 57796.0, 62054.0, 62428.68785656043, 62440.37559624346, 62473.68763156246, 63665.0, 12763.29801860888, 12848.807267890988, 12873.485060597472, 12882.162659427107, 12897.097203195874, 10062.849057264148, 10141.087302142694, 10146.13757830578, 10148.543315550818, 10148.644797432054, 19243.808852509403, 19866.801331986495, 20058.498537536678, 20089.296874609317, 20152.193912243638, 7423.85152296951, 7455.88161775738, 7505.924940750632, 7532.0, 7740.071191457061, 916.2532535983153, 922.4880191493785, 955.8948515663271, 972.2076507646245, 1041.8280983637767, 27072.729272707416, 27224.183274501796, 27415.588766168523, 27678.0, 27693.723062769517, 877.9736607901773, 884.1379654836611, 895.9776005599782, 929.3773171974793, 944.9952750236205, 14143.00998930065, 14357.64105897361, 14519.78220326696, 14615.488457903923, 15747.527574172793, 373466.0, 380117.0, 380521.0, 380530.0, 380919.0, 50900.745496272284, 51364.22953655698, 51475.0, 51511.0, 51561.48438515642, 1052.2634156090614, 1204.2714157934324, 1209.9637010889687, 1236.116176933479, 1247.3326770178094, 25976.48047039011, 27565.17304480869, 27829.582556262078, 27915.860420697765, 27951.58072628953, 38957.6104238954, 39553.80223098866, 39915.201695965334, 39927.80036099801, 39938.60061399349, 198185.0, 203697.0, 203890.0, 203964.0, 204476.0, 27703.722962770113, 31432.685673142976, 31790.52314215335, 31875.840620797677, 32186.517202241517, 37723.81138094292, 38767.22465550729, 39161.60838391694, 39207.0, 39570.40644390394, 30778.38443231078, 31090.0, 31199.0, 31602.683973159976, 31738.20654483564, 34965.825170875, 35567.64432355644, 35616.0, 35841.0, 36056.819715901256, 34843.0, 35035.64964350324, 35455.82272088623, 35578.0, 35830.82084589561, 31125.377492450476, 32023.519647205776, 32227.677723223405, 32286.35427291488, 32315.51526727148, 24853.875730621232, 24901.0, 24963.75036249687, 25235.74764252334, 25302.367440813392], "unit": "score", "name": "ext.html", "value": 17083.416680610197}, {"lowerIsBetter": false, "replicates": [338.82934461435735, 355.91991801844586, 356.11505409058486, 364.5188351376181, 367.3938002296211, 15540.378384864605, 15857.524274271762, 15888.443904463345, 16493.17534123295, 16918.238679259433, 15480.845191548082, 15554.84445155548, 16270.26783794729, 16273.674526509463, 16311.184440777974, 4894.339264199323, 4895.0, 5078.59371250301, 5095.184770436731, 5099.7705103270255, 5032.82385116521, 5034.84895453137, 5060.089183946888, 5082.974585127069, 5086.694798312114, 4874.173773587734, 5019.247112933052, 5037.4458809530925, 5049.368828896388, 5051.520105589963, 4941.728204948727, 4965.776540055688, 4980.352554167935, 4991.151504244251, 5008.373953255843, 4451.866444006685, 4481.170983368087, 4484.887877803081, 4488.506264310923, 4489.59593636571, 18199.45401637953, 19222.61554768897, 19356.90321548383, 19372.0, 19393.612127757508, 1868.7944326124116, 1876.5777700017386, 1918.098493707955, 1944.1542928826007, 2034.257496013959, 8724.345674074406, 9135.862962055575, 12471.812922806164, 12533.623991280276, 12903.419346129447, 1722.9569260768455, 1739.339051160551, 1772.645470905824, 1795.64087182564, 1801.5876553114135, 44051.77974110141, 54442.45557544453, 55705.44294557084, 55930.720346398004, 63008.36991630071, 9154.771130721652, 9214.0, 9250.814983700287, 9322.813543729088, 9335.579898904565, 12863.614091577268, 12919.289439080942, 12923.612291631267, 12947.611571652866, 12955.5465558705, 5944.346121926585, 6479.514036447191, 6742.292059333798, 6776.593404395752, 6804.693788779417, 6398.200224971879, 6430.228372595318, 6456.128422662974, 6543.378379053982, 6562.114114594564, 3880.3985382265796, 3939.212157568498, 3960.861369852099, 4057.3711074783455, 4137.338025915899, 1568.9450869219522, 1611.9113448760197, 1633.7141000325134, 1637.6806522727954, 1710.2560386232028, 845.8942632170979, 884.0, 937.1191080384417, 956.7799406136488, 1003.8494225866033, 14931.626709332137, 15039.774403383957, 15054.548363549111, 15142.470013549473, 15466.0, 857.562643052048, 868.86966954956, 871.3769654696922, 873.6461732998146, 879.1691851200554, 9168.724938251864, 9174.266058715286, 9223.907760922304, 9273.536323183815, 9435.0, 373122.0, 378851.0, 381787.0, 384213.0, 398319.0, 66612.0, 67106.32893671098, 67244.6637766808, 67469.66265168643, 67551.3244867545, 822.2928281677753, 882.5631312500353, 911.6991392840347, 937.639008981547, 940.6566603189787, 14608.853911461174, 14618.561443156723, 14687.339069741674, 14748.115113093249, 15010.249487525798, 32215.355692885543, 33184.834075829465, 33289.167770804954, 33326.50010249897, 33867.0, 44214.0, 44269.55730442654, 44291.77854110709, 45051.549484504736, 45430.54569454395, 6635.6350400728425, 6720.663966801738, 6762.594244345355, 6812.829679258059, 7132.322429369202, 8359.58202089881, 11280.0, 11657.475413606238, 11736.471858766547, 11792.587259445878, 10185.9490702546, 10270.33242839213, 10497.842532362174, 10565.20760942917, 10723.624673136403, 9902.306838521234, 9906.306558540833, 10019.248556358449, 10217.74455638615, 10494.790104198026, 10073.949630252095, 10169.542370593488, 10277.9486102569, 10383.486119626896, 10549.156067514426, 7231.310044540342, 7348.96325518369, 7391.667374968247, 7413.036305280495, 7444.0, 9508.952455237679, 9716.659916902874, 9738.610455581698, 9920.206383489447, 10000.59997600117], "unit": "score", "name": "jquery.html", "value": 7771.8860936040455}, {"lowerIsBetter": false, "replicates": [1287.1826390242193, 1340.5509154433264, 1368.9041767076303, 1498.5054931872482, 1801.2524802207076, 6772.796816095519, 7374.078240219973, 7505.512141710785, 7525.360344370735, 7532.983047288614, 7435.702571897131, 7641.2358764123555, 7652.081750189985, 7655.119661238959, 7660.195679453661, 1909.0, 2228.264672658027, 2229.2754854672257, 2261.2876943762744, 2282.863028218304, 2235.8993845277, 2245.393743689203, 2249.752527222004, 2250.504888924434, 2250.583642026222, 2144.731908511436, 2229.665550167472, 2230.587341341849, 2234.0616940884865, 2237.44063984004, 2198.230619283254, 2216.8115710164657, 2227.6881236626887, 2263.0, 2267.2064777327887, 2197.318831162329, 2215.8892055397164, 2228.476308067603, 2234.162189179058, 2252.0203711385434, 7702.191269916634, 7780.533168009937, 7780.766577002699, 7788.571628560427, 7792.4155688323035, 4306.590873866978, 4456.844010459651, 4458.866234012985, 4459.643228541709, 4460.598546130864, 2777.9305517362227, 2820.4500122476124, 2893.6816950135467, 2944.4994350960174, 2950.454165979301, 917.9127982841619, 932.5197523275518, 941.825762233982, 985.7979114281627, 989.4607438945792, 10379.273450858518, 10389.688309350731, 10403.219758518066, 10421.114205292559, 10424.374537527698, 4182.142660754538, 4217.768022758778, 4290.914181716348, 4304.074623955802, 4339.023719663113, 8922.910770892338, 8926.330525210506, 8960.32797540174, 8961.955190224138, 8977.28181745472, 3945.0, 4439.156560253541, 4480.0, 4485.6860019798305, 4486.865394038184, 3953.2291203215673, 3981.9203615927518, 3998.540167880673, 4030.7581545107387, 4038.414429907647, 3580.3197392495345, 3661.0847288177956, 3674.7427680062674, 3696.4085746281003, 3719.20037192005, 1176.670532250971, 1177.1936223686803, 1184.6268425445958, 1195.9701007474882, 1215.3558613934629, 940.2055263302499, 940.47333493244, 948.3551185193996, 978.471625322318, 1203.9939800301117, 7185.712571497186, 7186.245444228281, 7223.349898509159, 7249.601271930094, 7256.528325658815, 455.39659950565635, 463.87707257576767, 483.1713611156883, 484.1551492645356, 484.84727310896955, 5445.455454454523, 5548.55611551083, 5616.831495055155, 5621.0444224481935, 5641.323041235078, 8632.91367086321, 8858.601362938683, 8867.645294188289, 8872.467651940904, 8873.467591944504, 8730.69442569507, 8743.781405464913, 8744.562771861381, 8752.956235218911, 8764.079771623889, 6460.257070436866, 6589.110470086573, 6650.035744816974, 6699.564528305645, 6708.228553716288, 6484.059811327425, 6525.804225873231, 6529.183852018497, 6535.0, 6536.346365363425, 7576.696932122653, 7745.457817952914, 7874.842503150019, 7895.68417263303, 7921.089074756477, 7833.373330133461, 8009.879851802344, 8014.078380986261, 8141.755747327589, 8145.877811832709, 6270.404311590391, 6337.176167098432, 6402.679866006588, 6425.389587989133, 6426.260979987362, 6690.632015239208, 6699.19609646826, 6723.327667233238, 6729.831754206184, 6754.763583274562, 6187.412195841388, 6361.586496877688, 6388.329225431263, 6429.678516074271, 6439.7424103035355, 6303.338149494237, 6323.7786677466065, 6344.492440604833, 6429.678516074271, 6473.773417930538, 6807.523473357016, 6819.556728812611, 6824.727010919508, 6987.650617469005, 7001.684924178322, 6004.609700369462, 6178.969105154445, 6234.688265586612, 6243.500519958302, 6245.094461302995, 6398.71205795731, 6404.327545607644, 6427.292997770148, 6436.903446448214, 6443.065755465525], "unit": "score", "name": "mootools.html", "value": 4184.57544658611}, {"lowerIsBetter": false, "replicates": [310.72811290121143, 312.47504192955824, 320.8203406092589, 321.5085258932709, 322.74503142517426, 5268.288781014567, 5349.117395629726, 5380.704061276633, 5383.730813459331, 5398.757055932482, 5290.973545132269, 5292.126799078157, 5307.336582927134, 5311.707856067925, 5323.307969963899, 3902.1025164212247, 4019.9598004019876, 4156.2934301168725, 4159.0, 4161.3549899765585, 4168.7707176105305, 4193.937090943638, 4194.748315101088, 4203.5376108628025, 4210.62104410603, 4154.335306350985, 4155.605217504332, 4156.667466602679, 4160.54234034256, 4167.166566686659, 3932.9410058849, 4002.1795531916177, 4011.5587285398583, 4045.8786236412957, 4161.667066634662, 3555.9111022224392, 3610.151614370621, 3618.493410922473, 3618.710503159767, 3622.7826330419994, 5071.264666623356, 5097.082525145473, 5104.515071068243, 5106.519109458252, 5117.0, 4781.330613714048, 4782.641301902371, 4783.449903261135, 4792.544708252711, 4804.471508134103, 5605.775768969236, 5606.635568688022, 5608.971955140199, 5610.49505544503, 5621.747021384048, 4021.0, 4024.7383920045104, 4024.839006439739, 4026.778527181004, 4028.033272014725, 5729.312482502085, 5909.674967876765, 5912.231409916726, 5943.375945525744, 5961.076033214858, 3991.84032638697, 4007.5992400760274, 4020.778857162884, 4028.637422631977, 4031.637152656275, 4076.612721791425, 4079.9592004079577, 4083.1833633273463, 4086.203190377907, 4086.9386959195635, 4714.834980775657, 4715.74063426508, 4721.834735784231, 4722.905541889212, 4725.054989002213, 5658.603897727119, 5660.603757737002, 5670.489655930986, 5671.262735844314, 5674.517665998436, 1408.7112142010862, 1433.749093908562, 1437.3172742947017, 1438.8345340285791, 1439.6185010972101, 936.6768464879606, 948.2840455456087, 959.5346257065318, 965.971020869375, 967.56943160293, 4721.929171062437, 4791.544803243686, 4857.028594281158, 4870.95129048705, 4928.211486162269, 5887.411258874078, 5902.527797776168, 5910.556708246899, 5915.0, 5917.437843404869, 4922.803087876517, 4937.987712518925, 4938.506149385104, 4946.975265123651, 4948.480409556944, 3133.7022982816598, 3165.7309128723855, 3167.445697003015, 3171.0645359618966, 3172.5406313095773, 5441.483059109379, 5448.073827449343, 5458.863528411822, 5475.7262136893, 5476.26070480488, 5842.8539286517325, 6022.18700475439, 6033.698315084228, 6043.7280322385595, 6046.304674962347, 5423.810166644149, 5446.21029950655, 5447.673139611636, 5447.836564903059, 5453.3455985281225, 5799.333076696065, 5863.589548731547, 5864.853378665567, 5885.14665373527, 5885.176075349369, 5728.398518155534, 5752.0509115997065, 5755.5971082025535, 5769.307683078057, 5778.0, 5436.0, 5439.646422982493, 5451.100568406168, 5454.336427389526, 5454.645448045864, 3897.805109744558, 4002.9599704003754, 4017.578154293757, 4027.8993025174605, 4029.536603290659, 5817.981853175762, 5840.0, 5855.619384739978, 5858.384869588632, 5867.6772777497645, 5661.433856614306, 5669.433056694297, 5673.546116310603, 5679.091345384719, 5680.233168522362, 5602.607817452902, 5623.831285061455, 5652.463016013472, 5663.631863928831, 5664.461876121762, 5570.86072848182, 5582.0, 5587.636803607753, 5590.44095590454, 5593.412691667317, 5506.779728810803, 5698.8290351289525, 5705.885882282248, 5709.800156994485, 5710.8001219957105, 5499.450054994469, 5528.115501519737, 5532.889342213052, 5533.3083364579425, 5535.916961245665], "unit": "score", "name": "prototype.html", "value": 4228.403381421284}, {"lowerIsBetter": false, "replicates": [631.2015300644683, 655.2661019657983, 744.7170075371358, 749.4866016778507, 753.4800987318746, 11494.885051149486, 11627.941860290686, 11685.240459370136, 11692.29846209228, 11702.882971170297, 12113.0, 12177.878221217785, 13643.113197642171, 14060.296985150753, 14087.506937257198, 802.9317508011811, 814.4543156085437, 815.2011029191395, 816.4611356504709, 816.9714060007901, 530.9893802123955, 547.7535109200855, 548.1531034551627, 548.6077454619946, 641.1952998986266, 847.6397531049311, 849.7875531117221, 850.4599579267148, 851.1403482482675, 852.2287329966359, 664.8504086580529, 846.3779122345071, 848.3594885861166, 848.7878030492377, 849.2399302624148, 608.5101493297893, 615.1725928625991, 616.140484024783, 616.1774031667729, 616.2266355723583, 11678.357690327028, 11763.0, 11784.175107742376, 11792.23350482216, 11804.11469139818, 11609.6517104487, 11619.883801161965, 12012.69968250792, 12110.878891211063, 12557.0, 9667.178289845371, 9715.174210192143, 9806.607735690564, 9841.704748857546, 9908.851367229498, 3178.300773829754, 3214.5660335854595, 3247.951280730791, 3269.73842092632, 3271.509273608954, 43127.353089703676, 43259.78370108161, 43358.56641433577, 43538.12923741507, 43841.78079109616, 8706.507093603863, 8827.07315731839, 8885.511296878734, 9151.77120571991, 9166.49584272858, 16087.758683619755, 16219.756703649455, 16220.188990550425, 16376.0, 16869.0, 6285.214348206474, 6296.464800491918, 6322.114903913456, 6403.359664033653, 6428.485721142298, 3611.620779818134, 3660.7857465984684, 3698.9445158322646, 3725.590185079639, 3742.3450896093077, 2827.067067867599, 2842.971570284312, 2863.8568071596337, 2870.1963450233966, 2877.4676684813376, 507.1631807517552, 519.5947161214259, 525.7134861500415, 530.9946900531022, 532.0, 559.2561892682722, 578.2453897663505, 584.5791030458064, 590.0, 598.0938877600439, 7321.194668586451, 7389.963050184715, 7429.07136607924, 7572.4699271051595, 7671.53970761756, 485.6624645871156, 491.48885159433786, 537.7848860455771, 540.9675419474844, 552.4558310064583, 3383.120388698956, 3447.052060683282, 3465.428204346305, 3516.82415879205, 3528.3119791640897, 46915.5308446918, 48272.27591586129, 48446.5155348442, 48942.02115957661, 49075.75462122667, 40894.79552602218, 40957.79521102375, 41108.38337424941, 41121.0, 41603.37594936079, 39299.410508842964, 39349.40975885364, 39631.40552891709, 40110.19779604392, 40251.79874100611, 8081.595920204084, 8158.632861521364, 8187.631556579849, 8296.502209867427, 8396.118407567117, 31073.68926310708, 31141.8442907784, 31357.372852542365, 31510.842445787624, 32219.35561288808, 35525.644743552235, 35570.11074723153, 36213.456798148574, 38316.0, 38318.616813831504, 9910.35582687123, 10139.608341735044, 10150.086492215736, 10289.382637041503, 10533.525991330562, 10956.671299861016, 10957.232993690364, 10972.780544388908, 10974.561017559208, 11035.613753518588, 10442.738931526468, 10445.164386848883, 10758.0, 11083.833742493707, 11088.0, 9915.107640312119, 10212.897871021194, 10240.897591024292, 10287.742806429898, 10312.123469505175, 10564.181368244555, 10773.51519181623, 11047.613333533287, 11064.170187235828, 11114.944425277821, 7529.171791103084, 8302.381035697981, 9312.813743725223, 9544.141027307576, 9545.570449329936, 8670.869936951078, 8728.65085396577, 9149.63401463934, 9218.21645160169, 9273.814523709623], "unit": "score", "name": "yui.html", "value": 5669.405267573343}], "name": "dromaeo_css", "value": 6261.759374174311}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 106.0, 111.0, 112.0, 113.0, 100.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [166.0, 131.0, 160.0, 179.0, 137.0, 169.0, 154.0, 134.0, 175.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 153.8}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 159.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 105.0, 94.0, 74.0, 73.0, 74.0, 131.0, 110.0, 74.0], "unit": "score", "name": "audio-fft", "value": 88.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 146.0, 94.0, 101.0, 94.0, 132.0, 94.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 64.0, 76.0, 62.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 63.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 83.0, 83.0, 81.0, 82.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 116.0, 118.0, 129.0, 121.0, 116.0, 128.0, 124.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [143.0, 136.0, 130.0, 154.0, 143.0, 132.0, 141.0, 143.0, 143.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 68.0, 67.0, 70.0, 67.0, 66.0, 68.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1521.6}]} 02:34:02 INFO - Return code: 0 02:34:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:34:02 ERROR - # TBPL SUCCESS # 02:34:02 INFO - Running post-action listener: _resource_record_post_action 02:34:02 INFO - Running post-run listener: _resource_record_post_run 02:34:03 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 531714048; Read time: 8; Write time: 512644 02:34:03 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245067776; Read time: 0; Write time: 304180 02:34:03 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286646272; Read time: 8; Write time: 208464 02:34:03 INFO - Running post-run listener: _upload_blobber_files 02:34:03 INFO - Blob upload gear active. 02:34:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:03 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 02:34:03 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'] 02:34:03 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 02:34:04 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:34:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:05 INFO - (blobuploader) - INFO - Done attempting. 02:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:06 INFO - (blobuploader) - INFO - Done attempting. 02:34:06 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:06 INFO - Return code: 0 02:34:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3ca511d1630ab7a2796c3c1bfed1503cec1039fc88660ed557aaa5e62ff50ef231500fdb35b8a426b37554d3a9e773b79e497f19fbad608c9df57db4e8a3173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e81c6034cabd25320475708a174a25cde63486ba9c98f70013bd31031b78ce22b06d76b3f65a5993f31500bdfdceb530db4ad8e7f8ff7f09e28c5a7fddd09eb"} 02:34:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:06 INFO - Contents: 02:34:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3ca511d1630ab7a2796c3c1bfed1503cec1039fc88660ed557aaa5e62ff50ef231500fdb35b8a426b37554d3a9e773b79e497f19fbad608c9df57db4e8a3173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e81c6034cabd25320475708a174a25cde63486ba9c98f70013bd31031b78ce22b06d76b3f65a5993f31500bdfdceb530db4ad8e7f8ff7f09e28c5a7fddd09eb"} 02:34:06 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:06 INFO - Copying logs to upload dir... 02:34:06 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.780832 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-01 02:34:05.629191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 02:34:05.632608) ========= 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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 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/a3ca511d1630ab7a2796c3c1bfed1503cec1039fc88660ed557aaa5e62ff50ef231500fdb35b8a426b37554d3a9e773b79e497f19fbad608c9df57db4e8a3173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e81c6034cabd25320475708a174a25cde63486ba9c98f70013bd31031b78ce22b06d76b3f65a5993f31500bdfdceb530db4ad8e7f8ff7f09e28c5a7fddd09eb"} build_url:https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/fPvF8l_xQtausuN0bezFSg/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/a3ca511d1630ab7a2796c3c1bfed1503cec1039fc88660ed557aaa5e62ff50ef231500fdb35b8a426b37554d3a9e773b79e497f19fbad608c9df57db4e8a3173", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e81c6034cabd25320475708a174a25cde63486ba9c98f70013bd31031b78ce22b06d76b3f65a5993f31500bdfdceb530db4ad8e7f8ff7f09e28c5a7fddd09eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 02:34:05.657114) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:34:05.657447) ========= 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=0e2a256762fed810e2f0f810000001b3-1459501926.591862-1050913923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 02:34:05.742369) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 02:34:05.742727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 02:34:05.743010) ========= ========= Total master_lag: 0.28 =========