builder: date_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1456949823.36 results: success (0) buildid: 20160302093621 builduid: 85db4b06a19a42d284085a156f743966 revision: 7f88cd37dfe98b0caac965c36e731f2d5f10515b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.356478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.356923) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.357222) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006550 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.449467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.449779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.558799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.559121) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.611054) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.611373) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.611738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.612015) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 12:17:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.6M=0s 2016-03-02 12:17:04 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.782880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.783189) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019507 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.843007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:03.846406) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev 7f88cd37dfe98b0caac965c36e731f2d5f10515b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev 7f88cd37dfe98b0caac965c36e731f2d5f10515b --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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 12:17:04,399 truncating revision to first 12 chars 2016-03-02 12:17:04,399 Setting DEBUG logging. 2016-03-02 12:17:04,399 attempt 1/10 2016-03-02 12:17:04,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/7f88cd37dfe9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 12:17:04,682 unpacking tar archive at: date-7f88cd37dfe9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:04.482974) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:04.483312) ========= echo 7f88cd37dfe98b0caac965c36e731f2d5f10515b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7f88cd37dfe98b0caac965c36e731f2d5f10515b'] 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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7f88cd37dfe98b0caac965c36e731f2d5f10515b program finished with exit code 0 elapsedTime=0.004479 script_repo_revision: '7f88cd37dfe98b0caac965c36e731f2d5f10515b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:04.532387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:04.532663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 12:17:04.542422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-02 12:17:04.542693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-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', 'Date-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date-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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:05 INFO - MultiFileLogger online at 20160302 12:17:05 in /builds/slave/test 12:17:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date-Non-PGO 12:17:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:05 INFO - {'append_to_log': False, 12:17:05 INFO - 'base_work_dir': '/builds/slave/test', 12:17:05 INFO - 'blob_upload_branch': 'Date-Non-PGO', 12:17:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:05 INFO - 'branch': 'Date-Non-PGO', 12:17:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:05 INFO - 'config_files': ('talos/linux_config.py',), 12:17:05 INFO - 'default_actions': ('clobber', 12:17:05 INFO - 'read-buildbot-config', 12:17:05 INFO - 'download-and-extract', 12:17:05 INFO - 'populate-webroot', 12:17:05 INFO - 'create-virtualenv', 12:17:05 INFO - 'install', 12:17:05 INFO - 'run-tests'), 12:17:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:05 INFO - 'download_minidump_stackwalk': True, 12:17:05 INFO - 'download_symbols': 'ondemand', 12:17:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:05 INFO - 'installer_path': 'installer.exe', 12:17:05 INFO - 'log_level': 'info', 12:17:05 INFO - 'log_name': 'talos', 12:17:05 INFO - 'log_to_console': True, 12:17:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:05 INFO - 'opt_config_files': (), 12:17:05 INFO - 'pip_index': False, 12:17:05 INFO - 'sps_profile': False, 12:17:05 INFO - 'sps_profile_interval': 0, 12:17:05 INFO - 'suite': 'dromaeojs', 12:17:05 INFO - 'system_bits': '32', 12:17:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:05 INFO - 'title': 'talos-linux64-ix-036', 12:17:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:05 INFO - 'use_talos_json': True, 12:17:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:05 INFO - 'work_dir': 'build'} 12:17:05 INFO - ##### 12:17:05 INFO - ##### Running clobber step. 12:17:05 INFO - ##### 12:17:05 INFO - Running pre-action listener: _resource_record_pre_action 12:17:05 INFO - Running main action method: clobber 12:17:05 INFO - rmtree: /builds/slave/test/build 12:17:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:06 INFO - Running post-action listener: _resource_record_post_action 12:17:06 INFO - ##### 12:17:06 INFO - ##### Running read-buildbot-config step. 12:17:06 INFO - ##### 12:17:06 INFO - Running pre-action listener: _resource_record_pre_action 12:17:06 INFO - Running main action method: read_buildbot_config 12:17:06 INFO - Using buildbot properties: 12:17:06 INFO - { 12:17:06 INFO - "project": "", 12:17:06 INFO - "product": "firefox", 12:17:06 INFO - "script_repo_revision": "production", 12:17:06 INFO - "builddir": "date_ubuntu64_hw_test-dromaeojs", 12:17:06 INFO - "repository": "", 12:17:06 INFO - "buildername": "Ubuntu HW 12.04 x64 date talos dromaeojs", 12:17:06 INFO - "buildid": "20160302093621", 12:17:06 INFO - "pgo_build": "False", 12:17:06 INFO - "basedir": "/builds/slave/test", 12:17:06 INFO - "buildnumber": 1, 12:17:06 INFO - "slavename": "talos-linux64-ix-036", 12:17:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:17:06 INFO - "platform": "ubuntu64_hw", 12:17:06 INFO - "scheduler": "tests-date-linux64-talos", 12:17:06 INFO - "branch": "date", 12:17:06 INFO - "repo_path": "projects/date", 12:17:06 INFO - "revision": "7f88cd37dfe98b0caac965c36e731f2d5f10515b", 12:17:06 INFO - "stage_platform": "linux64", 12:17:06 INFO - "builduid": "85db4b06a19a42d284085a156f743966", 12:17:06 INFO - "slavebuilddir": "test" 12:17:06 INFO - } 12:17:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 12:17:06 INFO - Running post-action listener: _resource_record_post_action 12:17:06 INFO - ##### 12:17:06 INFO - ##### Running download-and-extract step. 12:17:06 INFO - ##### 12:17:06 INFO - Running pre-action listener: _resource_record_pre_action 12:17:06 INFO - Running main action method: download_and_extract 12:17:06 INFO - mkdir: /builds/slave/test/build/tests 12:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:06 INFO - https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/test_packages.json 12:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/test_packages.json 12:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:17:10 INFO - Downloaded 1412 bytes. 12:17:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:17:10 INFO - Using the following test package requirements: 12:17:10 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 12:17:10 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:10 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 12:17:10 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'jsshell-linux-x86_64.zip'], 12:17:10 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:10 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 12:17:10 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 12:17:10 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 12:17:10 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:10 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 12:17:10 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 12:17:10 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:10 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:10 INFO - https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:17:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:17:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:17:13 INFO - Downloaded 23267403 bytes. 12:17:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:17:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:17:14 INFO - Return code: 0 12:17:14 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:14 INFO - https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:17:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:17:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:17:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 12:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:17:15 INFO - Downloaded 23267403 bytes. 12:17:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:17:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:17:17 INFO - Return code: 0 12:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:17 INFO - https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 12:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 12:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 12:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:17:18 INFO - Downloaded 10707015 bytes. 12:17:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:17:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:17:18 INFO - Return code: 0 12:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:18 INFO - https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:17:19 INFO - Downloaded 53185324 bytes. 12:17:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:17:19 INFO - mkdir: /builds/slave/test/properties 12:17:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:19 INFO - Contents: 12:17:19 INFO - build_url:https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 12:17:20 INFO - Running post-action listener: _resource_record_post_action 12:17:20 INFO - Running post-action listener: set_extra_try_arguments 12:17:20 INFO - ##### 12:17:20 INFO - ##### Running populate-webroot step. 12:17:20 INFO - ##### 12:17:20 INFO - Running pre-action listener: _resource_record_pre_action 12:17:20 INFO - Running main action method: populate_webroot 12:17:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:20 INFO - '--tppagecycles', 12:17:20 INFO - '7'], 12:17:20 INFO - 'tests': ['tsvgm']}}, 12:17:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:17:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:17:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:17:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'tests': ['damp', 'tps']}, 12:17:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['damp', 'tps']}, 12:17:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:17:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:20 INFO - 'other': {'tests': ['a11yr', 12:17:20 INFO - 'ts_paint', 12:17:20 INFO - 'tpaint', 12:17:20 INFO - 'sessionrestore', 12:17:20 INFO - 'sessionrestore_no_auto_restore']}, 12:17:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['a11yr', 12:17:20 INFO - 'ts_paint', 12:17:20 INFO - 'tpaint', 12:17:20 INFO - 'sessionrestore', 12:17:20 INFO - 'sessionrestore_no_auto_restore']}, 12:17:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['a11yr', 12:17:20 INFO - 'ts_paint', 12:17:20 INFO - 'tpaint', 12:17:20 INFO - 'sessionrestore', 12:17:20 INFO - 'sessionrestore_no_auto_restore']}, 12:17:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['a11yr', 12:17:20 INFO - 'ts_paint', 12:17:20 INFO - 'tpaint', 12:17:20 INFO - 'sessionrestore', 12:17:20 INFO - 'sessionrestore_no_auto_restore']}, 12:17:20 INFO - 'other_l64': {'tests': ['a11yr', 12:17:20 INFO - 'ts_paint', 12:17:20 INFO - 'tpaint', 12:17:20 INFO - 'sessionrestore', 12:17:20 INFO - 'sessionrestore_no_auto_restore']}, 12:17:20 INFO - 'other_nol64': {'tests': ['a11yr', 12:17:20 INFO - 'ts_paint', 12:17:20 INFO - 'tpaint', 12:17:20 INFO - 'sessionrestore', 12:17:20 INFO - 'sessionrestore_no_auto_restore']}, 12:17:20 INFO - 'svgr': {'tests': ['tsvgx', 12:17:20 INFO - 'tsvgr_opacity', 12:17:20 INFO - 'tart', 12:17:20 INFO - 'tscrollx', 12:17:20 INFO - 'cart']}, 12:17:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['tsvgx', 12:17:20 INFO - 'tsvgr_opacity', 12:17:20 INFO - 'tart', 12:17:20 INFO - 'tscrollx', 12:17:20 INFO - 'cart']}, 12:17:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'tests': ['tp5o']}, 12:17:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'talos_options': ['--e10s'], 12:17:20 INFO - 'tests': ['tp5o']}, 12:17:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'talos_options': ['--xperf_path', 12:17:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:20 INFO - 'tests': ['tp5n']}, 12:17:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:20 INFO - 'talos_options': ['--e10s', 12:17:20 INFO - '--xperf_path', 12:17:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:20 INFO - 'tests': ['tp5n']}}, 12:17:20 INFO - 'talos.zip': {'path': '', 12:17:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:20 INFO - Running post-action listener: _resource_record_post_action 12:17:20 INFO - ##### 12:17:20 INFO - ##### Running create-virtualenv step. 12:17:20 INFO - ##### 12:17:20 INFO - Running pre-action listener: _resource_record_pre_action 12:17:20 INFO - Running main action method: create_virtualenv 12:17:20 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:17:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:20 INFO - Using real prefix '/usr' 12:17:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:21 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:23 INFO - Installing pip.................done. 12:17:23 INFO - Return code: 0 12:17:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:17:23 INFO - Using env: {'DISPLAY': ':0', 12:17:23 INFO - 'HOME': '/home/cltbld', 12:17:23 INFO - 'LANG': 'en_US.UTF-8', 12:17:23 INFO - 'LANGUAGE': 'en_US:en', 12:17:23 INFO - 'LOGNAME': 'cltbld', 12:17:23 INFO - 'MAIL': '/var/mail/cltbld', 12:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:23 INFO - 'MOZ_NO_REMOTE': '1', 12:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:23 INFO - 'NO_EM_RESTART': '1', 12:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:23 INFO - 'PWD': '/builds/slave/test', 12:17:23 INFO - 'SHELL': '/bin/bash', 12:17:23 INFO - 'SHLVL': '1', 12:17:23 INFO - 'TERM': 'linux', 12:17:23 INFO - 'TMOUT': '86400', 12:17:23 INFO - 'USER': 'cltbld', 12:17:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:23 INFO - '_': '/tools/buildbot/bin/python'} 12:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:17:23 INFO - Cleaning up... 12:17:23 INFO - Return code: 0 12:17:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:17:23 INFO - Using env: {'DISPLAY': ':0', 12:17:23 INFO - 'HOME': '/home/cltbld', 12:17:23 INFO - 'LANG': 'en_US.UTF-8', 12:17:23 INFO - 'LANGUAGE': 'en_US:en', 12:17:23 INFO - 'LOGNAME': 'cltbld', 12:17:23 INFO - 'MAIL': '/var/mail/cltbld', 12:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:23 INFO - 'MOZ_NO_REMOTE': '1', 12:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:23 INFO - 'NO_EM_RESTART': '1', 12:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:23 INFO - 'PWD': '/builds/slave/test', 12:17:23 INFO - 'SHELL': '/bin/bash', 12:17:23 INFO - 'SHLVL': '1', 12:17:23 INFO - 'TERM': 'linux', 12:17:23 INFO - 'TMOUT': '86400', 12:17:23 INFO - 'USER': 'cltbld', 12:17:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:23 INFO - '_': '/tools/buildbot/bin/python'} 12:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:23 INFO - Downloading/unpacking psutil>=0.7.1 12:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:25 INFO - Installing collected packages: psutil 12:17:25 INFO - Running setup.py install for psutil 12:17:25 INFO - building 'psutil._psutil_linux' extension 12:17:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:17:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:17:25 INFO - building 'psutil._psutil_posix' extension 12:17:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:17:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:17:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:26 INFO - Successfully installed psutil 12:17:26 INFO - Cleaning up... 12:17:26 INFO - Return code: 0 12:17:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:17:26 INFO - Using env: {'DISPLAY': ':0', 12:17:26 INFO - 'HOME': '/home/cltbld', 12:17:26 INFO - 'LANG': 'en_US.UTF-8', 12:17:26 INFO - 'LANGUAGE': 'en_US:en', 12:17:26 INFO - 'LOGNAME': 'cltbld', 12:17:26 INFO - 'MAIL': '/var/mail/cltbld', 12:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:26 INFO - 'MOZ_NO_REMOTE': '1', 12:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:26 INFO - 'NO_EM_RESTART': '1', 12:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:26 INFO - 'PWD': '/builds/slave/test', 12:17:26 INFO - 'SHELL': '/bin/bash', 12:17:26 INFO - 'SHLVL': '1', 12:17:26 INFO - 'TERM': 'linux', 12:17:26 INFO - 'TMOUT': '86400', 12:17:26 INFO - 'USER': 'cltbld', 12:17:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:26 INFO - '_': '/tools/buildbot/bin/python'} 12:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:17:28 INFO - Installing collected packages: mozsystemmonitor 12:17:28 INFO - Running setup.py install for mozsystemmonitor 12:17:28 INFO - Successfully installed mozsystemmonitor 12:17:28 INFO - Cleaning up... 12:17:28 INFO - Return code: 0 12:17:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:28 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 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:17:28 INFO - Using env: {'DISPLAY': ':0', 12:17:28 INFO - 'HOME': '/home/cltbld', 12:17:28 INFO - 'LANG': 'en_US.UTF-8', 12:17:28 INFO - 'LANGUAGE': 'en_US:en', 12:17:28 INFO - 'LOGNAME': 'cltbld', 12:17:28 INFO - 'MAIL': '/var/mail/cltbld', 12:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:28 INFO - 'MOZ_NO_REMOTE': '1', 12:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:28 INFO - 'NO_EM_RESTART': '1', 12:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:28 INFO - 'PWD': '/builds/slave/test', 12:17:28 INFO - 'SHELL': '/bin/bash', 12:17:28 INFO - 'SHLVL': '1', 12:17:28 INFO - 'TERM': 'linux', 12:17:28 INFO - 'TMOUT': '86400', 12:17:28 INFO - 'USER': 'cltbld', 12:17:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:28 INFO - '_': '/tools/buildbot/bin/python'} 12:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:28 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:30 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:31 INFO - Downloading docopt-0.6.1.tar.gz 12:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:31 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:31 INFO - Running setup.py install for blobuploader 12:17:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:31 INFO - Running setup.py install for requests 12:17:31 INFO - Running setup.py install for docopt 12:17:31 INFO - Successfully installed blobuploader requests docopt 12:17:31 INFO - Cleaning up... 12:17:31 INFO - Return code: 0 12:17:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:31 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 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:17:31 INFO - Using env: {'DISPLAY': ':0', 12:17:31 INFO - 'HOME': '/home/cltbld', 12:17:31 INFO - 'LANG': 'en_US.UTF-8', 12:17:31 INFO - 'LANGUAGE': 'en_US:en', 12:17:31 INFO - 'LOGNAME': 'cltbld', 12:17:31 INFO - 'MAIL': '/var/mail/cltbld', 12:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:31 INFO - 'MOZ_NO_REMOTE': '1', 12:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:31 INFO - 'NO_EM_RESTART': '1', 12:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:31 INFO - 'PWD': '/builds/slave/test', 12:17:31 INFO - 'SHELL': '/bin/bash', 12:17:31 INFO - 'SHLVL': '1', 12:17:31 INFO - 'TERM': 'linux', 12:17:31 INFO - 'TMOUT': '86400', 12:17:31 INFO - 'USER': 'cltbld', 12:17:31 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:31 INFO - '_': '/tools/buildbot/bin/python'} 12:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:31 INFO - Running setup.py (path:/tmp/pip-G1s7BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:32 INFO - Running setup.py (path:/tmp/pip-MLk7VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:32 INFO - Running setup.py (path:/tmp/pip-LO8yBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:32 INFO - Running setup.py (path:/tmp/pip-N7AETV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:32 INFO - Running setup.py (path:/tmp/pip-8UWZ5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:32 INFO - Running setup.py (path:/tmp/pip-T2d8zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:32 INFO - Running setup.py (path:/tmp/pip-qGAFv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:32 INFO - Running setup.py (path:/tmp/pip-H9mEUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:32 INFO - Running setup.py (path:/tmp/pip-bV056f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:32 INFO - Running setup.py (path:/tmp/pip-YybTxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:32 INFO - Running setup.py (path:/tmp/pip-UNpB67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:32 INFO - Running setup.py (path:/tmp/pip-QUlHsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:32 INFO - Running setup.py (path:/tmp/pip-kIJ6B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:32 INFO - Running setup.py (path:/tmp/pip-iTgxQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:32 INFO - Running setup.py (path:/tmp/pip-g6wHXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:33 INFO - Running setup.py (path:/tmp/pip-DA_9iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:33 INFO - Running setup.py (path:/tmp/pip-kD5pNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:33 INFO - Running setup.py install for manifestparser 12:17:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Running setup.py install for mozcrash 12:17:33 INFO - Running setup.py install for mozdebug 12:17:33 INFO - Running setup.py install for mozdevice 12:17:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Running setup.py install for mozfile 12:17:33 INFO - Running setup.py install for mozhttpd 12:17:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Running setup.py install for mozinfo 12:17:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Running setup.py install for mozInstall 12:17:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:33 INFO - Running setup.py install for mozleak 12:17:34 INFO - Running setup.py install for mozlog 12:17:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Running setup.py install for moznetwork 12:17:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Running setup.py install for mozprocess 12:17:34 INFO - Running setup.py install for mozprofile 12:17:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Running setup.py install for mozrunner 12:17:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Running setup.py install for mozscreenshot 12:17:34 INFO - Running setup.py install for moztest 12:17:34 INFO - Running setup.py install for mozversion 12:17:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:34 INFO - Cleaning up... 12:17:34 INFO - Return code: 0 12:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:34 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 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:17:34 INFO - Using env: {'DISPLAY': ':0', 12:17:34 INFO - 'HOME': '/home/cltbld', 12:17:34 INFO - 'LANG': 'en_US.UTF-8', 12:17:34 INFO - 'LANGUAGE': 'en_US:en', 12:17:34 INFO - 'LOGNAME': 'cltbld', 12:17:34 INFO - 'MAIL': '/var/mail/cltbld', 12:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:34 INFO - 'MOZ_NO_REMOTE': '1', 12:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:34 INFO - 'NO_EM_RESTART': '1', 12:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:34 INFO - 'PWD': '/builds/slave/test', 12:17:34 INFO - 'SHELL': '/bin/bash', 12:17:34 INFO - 'SHLVL': '1', 12:17:34 INFO - 'TERM': 'linux', 12:17:34 INFO - 'TMOUT': '86400', 12:17:34 INFO - 'USER': 'cltbld', 12:17:34 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:34 INFO - '_': '/tools/buildbot/bin/python'} 12:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:35 INFO - Running setup.py (path:/tmp/pip-k0_7pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:35 INFO - Running setup.py (path:/tmp/pip-rndNN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:35 INFO - Running setup.py (path:/tmp/pip-8ZRoTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:35 INFO - Running setup.py (path:/tmp/pip-05Gip2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:35 INFO - Running setup.py (path:/tmp/pip-6tBfoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:35 INFO - Running setup.py (path:/tmp/pip-yOxtCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:35 INFO - Running setup.py (path:/tmp/pip-aO1pqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:35 INFO - Running setup.py (path:/tmp/pip-6qX3Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:35 INFO - Running setup.py (path:/tmp/pip-CMKvcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:35 INFO - Running setup.py (path:/tmp/pip-dx2PqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:35 INFO - Running setup.py (path:/tmp/pip-wwv8K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:36 INFO - Running setup.py (path:/tmp/pip-yOfvf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:36 INFO - Running setup.py (path:/tmp/pip-a9BL0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:36 INFO - Running setup.py (path:/tmp/pip-DiZysZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:36 INFO - Running setup.py (path:/tmp/pip-MLGbod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:36 INFO - Running setup.py (path:/tmp/pip-JESkmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:36 INFO - Running setup.py (path:/tmp/pip-TPndv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:17:36 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:36 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:17:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:38 INFO - Downloading blessings-1.6.tar.gz 12:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:38 INFO - Installing collected packages: blessings 12:17:38 INFO - Running setup.py install for blessings 12:17:38 INFO - Successfully installed blessings 12:17:38 INFO - Cleaning up... 12:17:38 INFO - Return code: 0 12:17:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:38 INFO - Reading from file tmpfile_stdout 12:17:38 INFO - Current package versions: 12:17:38 INFO - argparse == 1.2.1 12:17:38 INFO - blessings == 1.6 12:17:38 INFO - blobuploader == 1.2.4 12:17:38 INFO - docopt == 0.6.1 12:17:38 INFO - manifestparser == 1.1 12:17:38 INFO - mozInstall == 1.12 12:17:38 INFO - mozcrash == 0.16 12:17:38 INFO - mozdebug == 0.1 12:17:38 INFO - mozdevice == 0.48 12:17:38 INFO - mozfile == 1.2 12:17:38 INFO - mozhttpd == 0.7 12:17:38 INFO - mozinfo == 0.9 12:17:38 INFO - mozleak == 0.1 12:17:38 INFO - mozlog == 3.1 12:17:38 INFO - moznetwork == 0.27 12:17:38 INFO - mozprocess == 0.22 12:17:38 INFO - mozprofile == 0.28 12:17:38 INFO - mozrunner == 6.11 12:17:38 INFO - mozscreenshot == 0.1 12:17:38 INFO - mozsystemmonitor == 0.0 12:17:38 INFO - moztest == 0.7 12:17:38 INFO - mozversion == 1.4 12:17:38 INFO - psutil == 3.1.1 12:17:38 INFO - requests == 1.2.3 12:17:38 INFO - wsgiref == 0.1.2 12:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:38 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 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:17:38 INFO - Using env: {'DISPLAY': ':0', 12:17:38 INFO - 'HOME': '/home/cltbld', 12:17:38 INFO - 'LANG': 'en_US.UTF-8', 12:17:38 INFO - 'LANGUAGE': 'en_US:en', 12:17:38 INFO - 'LOGNAME': 'cltbld', 12:17:38 INFO - 'MAIL': '/var/mail/cltbld', 12:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:38 INFO - 'MOZ_NO_REMOTE': '1', 12:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:38 INFO - 'NO_EM_RESTART': '1', 12:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:38 INFO - 'PWD': '/builds/slave/test', 12:17:38 INFO - 'SHELL': '/bin/bash', 12:17:38 INFO - 'SHLVL': '1', 12:17:38 INFO - 'TERM': 'linux', 12:17:38 INFO - 'TMOUT': '86400', 12:17:38 INFO - 'USER': 'cltbld', 12:17:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:38 INFO - '_': '/tools/buildbot/bin/python'} 12:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:17:39 INFO - Cleaning up... 12:17:39 INFO - Return code: 0 12:17:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:17:39 INFO - Using env: {'DISPLAY': ':0', 12:17:39 INFO - 'HOME': '/home/cltbld', 12:17:39 INFO - 'LANG': 'en_US.UTF-8', 12:17:39 INFO - 'LANGUAGE': 'en_US:en', 12:17:39 INFO - 'LOGNAME': 'cltbld', 12:17:39 INFO - 'MAIL': '/var/mail/cltbld', 12:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:39 INFO - 'MOZ_NO_REMOTE': '1', 12:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:39 INFO - 'NO_EM_RESTART': '1', 12:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:39 INFO - 'PWD': '/builds/slave/test', 12:17:39 INFO - 'SHELL': '/bin/bash', 12:17:39 INFO - 'SHLVL': '1', 12:17:39 INFO - 'TERM': 'linux', 12:17:39 INFO - 'TMOUT': '86400', 12:17:39 INFO - 'USER': 'cltbld', 12:17:39 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:39 INFO - '_': '/tools/buildbot/bin/python'} 12:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:39 INFO - Downloading/unpacking jsonschema 12:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:17:41 INFO - Downloading/unpacking functools32 (from jsonschema) 12:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:17:41 INFO - warning: no files found matching '*.txt' 12:17:41 INFO - no previously-included directories found matching 'build' 12:17:41 INFO - no previously-included directories found matching 'dist' 12:17:41 INFO - no previously-included directories found matching '.git*' 12:17:41 INFO - Installing collected packages: jsonschema, functools32 12:17:41 INFO - Running setup.py install for functools32 12:17:41 INFO - warning: no files found matching '*.txt' 12:17:41 INFO - no previously-included directories found matching 'build' 12:17:41 INFO - no previously-included directories found matching 'dist' 12:17:41 INFO - no previously-included directories found matching '.git*' 12:17:41 INFO - Successfully installed jsonschema functools32 12:17:41 INFO - Cleaning up... 12:17:41 INFO - Return code: 0 12:17:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:17: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')]} 12:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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')]} 12:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:41 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 0x7ff758da6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe833b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, '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': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:17:41 INFO - Using env: {'DISPLAY': ':0', 12:17:41 INFO - 'HOME': '/home/cltbld', 12:17:41 INFO - 'LANG': 'en_US.UTF-8', 12:17:41 INFO - 'LANGUAGE': 'en_US:en', 12:17:41 INFO - 'LOGNAME': 'cltbld', 12:17:41 INFO - 'MAIL': '/var/mail/cltbld', 12:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:41 INFO - 'MOZ_NO_REMOTE': '1', 12:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:41 INFO - 'NO_EM_RESTART': '1', 12:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:41 INFO - 'PWD': '/builds/slave/test', 12:17:41 INFO - 'SHELL': '/bin/bash', 12:17:41 INFO - 'SHLVL': '1', 12:17:41 INFO - 'TERM': 'linux', 12:17:41 INFO - 'TMOUT': '86400', 12:17:41 INFO - 'USER': 'cltbld', 12:17:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:41 INFO - '_': '/tools/buildbot/bin/python'} 12:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:41 INFO - Downloading/unpacking flake8 12:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:17:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:17:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:44 INFO - no previously-included directories found matching 'docs/_build' 12:17:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:17:44 INFO - Running setup.py install for pep8 12:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:17:44 INFO - no previously-included directories found matching 'docs/_build' 12:17:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:17:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:17:44 INFO - Cleaning up... 12:17:44 INFO - Return code: 0 12:17:44 INFO - Running post-action listener: _resource_record_post_action 12:17:44 INFO - Running post-action listener: _start_resource_monitoring 12:17:44 INFO - Starting resource monitoring. 12:17:44 INFO - ##### 12:17:44 INFO - ##### Running install step. 12:17:44 INFO - ##### 12:17:44 INFO - Running pre-action listener: _resource_record_pre_action 12:17:44 INFO - Running main action method: install 12:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:44 INFO - Reading from file tmpfile_stdout 12:17:44 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:44 INFO - Reading from file tmpfile_stdout 12:17:44 INFO - Output received: 12:17:44 INFO - Usage: mozinstall [options] installer 12:17:44 INFO - Options: 12:17:44 INFO - -h, --help show this help message and exit 12:17:44 INFO - -d DEST, --destination=DEST 12:17:44 INFO - Directory to install application into. [default: 12:17:44 INFO - "/builds/slave/test"] 12:17:44 INFO - --app=APP Application being installed. [default: firefox] 12:17:44 INFO - mkdir: /builds/slave/test/build/application 12:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:17:57 INFO - Reading from file tmpfile_stdout 12:17:57 INFO - Output received: 12:17:57 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:57 INFO - Running post-action listener: _resource_record_post_action 12:17:57 INFO - ##### 12:17:57 INFO - ##### Running run-tests step. 12:17:57 INFO - ##### 12:17:57 INFO - Running pre-action listener: _resource_record_pre_action 12:17:57 INFO - Running main action method: run_tests 12:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:57 INFO - Python 2.7.3 12:17:57 INFO - Return code: 0 12:17:57 INFO - grabbing minidump binary from tooltool 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:57 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 0xf12100>, '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 0xf13000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf13490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:17:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:17:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:57 INFO - Return code: 0 12:17:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:17:58 INFO - Return code: 0 12:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:17:58 INFO - Using env: {'DISPLAY': ':0', 12:17:58 INFO - 'HOME': '/home/cltbld', 12:17:58 INFO - 'LANG': 'en_US.UTF-8', 12:17:58 INFO - 'LANGUAGE': 'en_US:en', 12:17:58 INFO - 'LOGNAME': 'cltbld', 12:17:58 INFO - 'MAIL': '/var/mail/cltbld', 12:17:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:58 INFO - 'MOZ_NO_REMOTE': '1', 12:17:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:58 INFO - 'NO_EM_RESTART': '1', 12:17:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:58 INFO - 'PWD': '/builds/slave/test', 12:17:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:58 INFO - 'SHELL': '/bin/bash', 12:17:58 INFO - 'SHLVL': '1', 12:17:58 INFO - 'TERM': 'linux', 12:17:58 INFO - 'TMOUT': '86400', 12:17:58 INFO - 'USER': 'cltbld', 12:17:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769', 12:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:58 INFO - '_': '/tools/buildbot/bin/python'} 12:17:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:17:58 INFO - mozversion application_buildid: 20160302093621 12:17:58 INFO - mozversion application_changeset: 7f88cd37dfe98b0caac965c36e731f2d5f10515b 12:17:58 INFO - mozversion application_display_name: Firefox 12:17:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:58 INFO - mozversion application_name: Firefox 12:17:58 INFO - mozversion application_remotingname: firefox 12:17:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 12:17:58 INFO - mozversion application_vendor: Mozilla 12:17:58 INFO - mozversion application_version: 47.0 12:17:58 INFO - mozversion platform_buildid: 20160302093621 12:17:58 INFO - mozversion platform_changeset: 7f88cd37dfe98b0caac965c36e731f2d5f10515b 12:17:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 12:17:58 INFO - mozversion platform_version: 47.0 12:17:58 INFO - using testdate: 1456949878 12:17:58 INFO - actual date: 1456949878 12:17:58 INFO - starting webserver on 'localhost:54238' 12:17:58 INFO - SUITE-START | Running 2 tests 12:17:58 INFO - TEST-START | dromaeo_css 12:17:58 INFO - operating with platform_type : linux_ 12:17:58 INFO - Initialising browser for dromaeo_css test... 12:17:58 INFO - TEST-INFO | started process 24738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1VMQ2T/profile http://localhost:54238/getInfo.html) 12:18:03 INFO - PROCESS | 24738 | __metrics Screen width/height:1600/1200 12:18:03 INFO - PROCESS | 24738 | colorDepth:24 12:18:03 INFO - PROCESS | 24738 | Browser inner width/height: 1024/697 12:18:03 INFO - PROCESS | 24738 | __metrics 12:18:04 INFO - PROCESS | 24738 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:18:05 INFO - TEST-INFO | 24738: exit 0 12:18:05 INFO - Browser initialized. 12:18:05 INFO - Running cycle 1/1 for dromaeo_css test... 12:18:05 INFO - TEST-INFO | started process 24829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1VMQ2T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:17 INFO - PROCESS | 24829 | RSS: Main: 133484544 12:18:17 INFO - PROCESS | 24829 | 12:19:08 INFO - PROCESS | 24829 | 1456949948176 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:21:15 INFO - PROCESS | 24829 | Cycle 1(1): loaded http://localhost:54238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54238/tests/dromaeo/cssquery-ext.html) 12:21:16 INFO - PROCESS | 24829 | RSS: Main: 220962816 12:21:16 INFO - PROCESS | 24829 | 12:24:18 INFO - PROCESS | 24829 | Cycle 1(1): loaded http://localhost:54238/tests/dromaeo/cssquery-ext.html (next: http://localhost:54238/tests/dromaeo/cssquery-jquery.html) 12:24:19 INFO - PROCESS | 24829 | RSS: Main: 224690176 12:24:19 INFO - PROCESS | 24829 | 12:27:21 INFO - PROCESS | 24829 | Cycle 1(1): loaded http://localhost:54238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54238/tests/dromaeo/cssquery-mootools.html) 12:27:21 INFO - PROCESS | 24829 | RSS: Main: 211075072 12:27:21 INFO - PROCESS | 24829 | 12:30:23 INFO - PROCESS | 24829 | Cycle 1(1): loaded http://localhost:54238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54238/tests/dromaeo/cssquery-prototype.html) 12:30:24 INFO - PROCESS | 24829 | RSS: Main: 200495104 12:30:24 INFO - PROCESS | 24829 | 12:33:26 INFO - PROCESS | 24829 | Cycle 1(1): loaded http://localhost:54238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54238/tests/dromaeo/cssquery-yui.html) 12:33:27 INFO - PROCESS | 24829 | RSS: Main: 174260224 12:33:27 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | Cycle 1(1): loaded http://localhost:54238/tests/dromaeo/cssquery-yui.html (next: http://localhost:54238/tests/dromaeo/cssquery-dojo.html) 12:36:29 INFO - PROCESS | 24829 | RSS: Main: 237326336 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | __start_tp_report 12:36:29 INFO - PROCESS | 24829 | _x_x_mozilla_page_load 12:36:29 INFO - PROCESS | 24829 | _x_x_mozilla_page_load_details 12:36:29 INFO - PROCESS | 24829 | |i|pagename|runs| 12:36:29 INFO - PROCESS | 24829 | |0;dojo.html;3215.340855124699;3260.6576309487486;3290.0294413148135;3295.2585668224638;3324.850381732822;5264.947350526493;5283.313169287992;5287.814926477574;5303.337082864642;5329.094054010813;5288.497592728694;5296.09966305728;5327.36071671399;5339.199120131982;5340.0654885395;4762.618990480771;4833.903321933559;4914.164592019356;4926.162552366106;4969.055879382924;4785.904281914377;4849.806007759686;4850.854474365757;4852.102361063197;4857.854264372057;4843.564079232869;4892.951070489303;4897.142999975008;4901.583365413944;4949.133901567229;4376.715513491613;4879.048585525824;4896.143174944388;4908.214685650279;4911.852644420673;4760.523947605212;4835.516448355136;4838.903221935577;4872.4640289568115;4881.51184881509;5166.380034395859;5191.325127733408;5199.558037566811;5210.713410762407;5213.322268105122;5512.641678290898;5644.6330988486025;5713.514351280146;5722.713864306768;5726.713664316768;5729.1119876419225;5729.9713501432225;5730.05454100073;5743.16724075011;5748.913766293509;5401.918971215396;5402.756875940592;5407.891842163135;5408.729563521848;5412.07994640912;5663.405342439067;5720.056190728483;5731.799387021434;5771.85570360736;5809.244798176294;5606.327240731139;5607.495325420732;5607.8598035048635;5619.381867994517;5622.044252477089;5560.360558535739;5688.800891968844;5692.800751973661;5708.686022268815;5719.48524632785;5699.316082070095;5704.686242256633;5707.058335374617;5710.771569137188;5761.884762304814;5707.143928410772;5709.286339207599;5710.229119068873;5710.257666503411;5715.199872017921;4256.382824490432;4324.502682191588;4359.9782001090425;4408.404865343137;4410.250257456176;3898.922021559553;3909.6872250219913;3910.2961466936226;3928.8035598219976;3933.7443066200603;5292.311999440049;5305.734713264398;5309.46905309466;5331.466853314715;5331.600129990189;5594.832155035356;5617.719114044363;5670.971645141831;5697.686627235542;5726.341470730836;5379.515843574019;5386.084365657847;5410.756515956791;5453.809116680897;5455.918161227585;4880;4882.389701287339;4888.902221955541;4898.191798353303;4923.679960802608;5865.384134665798;5898.734556944948;5903.321118071391;5907.409259074144;5945.048792193228;5558.610897237155;5594.692291923983;5657.575681823797;5666.15007748841;5836.241288632451;5827.271591051119;5854.209681692917;5886.293644762656;5915.615484993634;5932.347441781314;5629;5629.493345598916;5630.690312032878;5633.577481688808;5638.097904335286;5693.971530142323;5694.658320500783;5700.486956173964;5707.885842283048;5708.914366284592;5452.7546260417585;5574.470425309589;5646.0683987141665;5659.688717120598;5674.716264186856;5556.833295001156;5561.833145005657;5562.860928476659;5564.749586268708;5574.303212098488;5369.5167434931045;5446.727663616883;5503.532199762904;5508.91736623959;5528.06022976103;5630.718464076698;5652.321721393295;5683;5691.686957217393;5693.829185124453;5520.282363292747;5524.917126243029;5541.224228607917;5542.7782888684005;5548.750306236148 12:36:29 INFO - PROCESS | 24829 | |1;ext.html;521.5957632834551;556.8719194585248;557.3757391721272;580.9157672137538;592.9978336611127;30564.235894102632;38718.41922371163;39076.413853792146;39093.413598796;39120;42439.15121697564;42913.7854310728;43040.139197216035;43058.784706076425;43068;8753.212210901034;8925;8948.418352807046;8963.910360896372;8967.192952634261;8829.117088291183;8971.416857904247;8979.730608081736;8981.595828187747;9236.21492173166;9171.495567743772;9244.352895297297;9264.258859291274;9268.351215414923;9272.72181834546;9143.08569143087;9233.584488698025;9234.30742694294;9235.215006724404;9236.630534778635;9026.368154229207;9108.271338292987;9128.3153763468;9149.039350868195;9150.954245228731;41501.58498415037;42008.78995605002;42031;42068.78965605183;42097;3505.9474107888145;3676.8161591920298;3828.712846536521;4211.557786432411;4728.05438912219;28762.568561471595;29163;29367.55948660772;29372;29822.10533683993;3651.434027725707;4230.51349094855;4314.158739045887;4330.805113769888;4351.369051487517;297022;300354;300693;300720;341816.9999999975;59825.401745982854;60257;60372.39627603668;60580.394196057474;60584.394156057875;65289.67355163194;65500.672496638166;65549;65645;65652.67173664196;16012;16236.188190590423;16237.675246495004;16254.268557914686;16269.18654067292;11424.314541127558;11564.95915367621;11653.067754579613;11682.883171168349;11707.531698731955;22345.664815027787;22465.663015054786;22476.213332533283;22481.775182248297;22496.887515562317;8683.565821709015;8721.60752766127;8733;8749.343799214957;8754.21212090915;1062.0706881478707;1113.2986218682179;1145.352875625269;1156.5836298932377;1167.416291854073;27322.180334589597;32164.678353216637;32498.675013249565;32760;33063.17342066419;1008.1279693065592;1086.6631344283298;1120.1878637987395;1149.149629274331;1197.3833475759816;14556.781648275284;14740.557783266519;15143.545693628988;15226.314815833313;16709.91645041767;408117;410678;411658;413100;415974;56908.43091569114;56961;57003.714981424826;57217.427825721206;57240.713796431584;1494.2454060699276;1494.7160039592661;1494.9103053816805;1503;1507.3593722668043;30286.54570181405;30360.84819575888;30521.23696907595;30985.69014309828;31002.534961975136;47659;48185.75907120442;48333.27500087572;48379.51620483891;48422;295715;296214;297852;297994;298033;28969.275768105967;35530.28939421249;35609.82195089008;35627.46558801568;36107;54579.72710136424;55130.06175880742;58963;59422;60490.69754651198;38911.221775564896;39680.2063958725;44025.339619906365;44193;45915.31127033164;39246.803765980985;40449.39325910055;40480.1903961925;43403;44008.779956100014;41347.379789302584;41533.37699934564;42201;42263.7886810564;42733.7179884604;37547.81226093852;37660.62339376681;38428.80785596166;38721.6127838718;38747.225055498166;28049.57925631158;28413;28501.714982850735;28599.571006435337;28709.138725838257 12:36:29 INFO - PROCESS | 24829 | |2;jquery.html;376.4485029431884;378.1359593329243;382.2794033247328;384.74030029729926;385.63557438220886;14547.418103275857;14908.030977986451;17262.309507619695;17280.74078888816;17839.464816055523;16594.58513537162;16740;17142;18096.457106286798;18102.366417175403;5500.972495137528;5516.282883225195;5693;5706.543476521889;5730.627509211888;4151.730137541065;5618.325800903897;5958.28500579931;6199.163112979758;6214.65819379934;6147.661878596676;6149.16986206863;6155.815325540241;6171.660558669271;6174.876502469948;5934.664700442409;6253.53098517613;6263.217097862767;6275.372462753734;6276.058591211332;5479.726013699299;5521.089020311644;5521.668699878021;5546.057170281062;5548.722563871831;20637.58724825495;20998.685019724715;21139.04874280661;21159;21195.25816596412;1918.8656794024423;1927.575933294673;2064.917403303866;2230.9514528171735;2448.5592593333195;13536.729265414637;13543.45826166952;13656.180629162183;13739.175649461064;14142.505012324622;1962.3131903833687;2055.640262953977;2056.7120603115577;2056.856020078595;2071.7513898332145;63350.36649633491;63685.68157159231;64038.67980660067;64077;66267.40947075227;10339;10865.728356791144;10947.233693641369;10963.068139208257;11017.559297628166;14357.6410589734;14384.496542621167;14504.419823206954;14505.057171283834;14509.419623214953;7803;7903.525788452711;7912.0505539335645;7940.841183176304;7964.2433968772875;7585.355244804143;7609.809754756065;7624.656890439944;7646.732364367332;7653.234676532414;4691.366665500182;4754.9286760698615;4766.451858036301;4774.379330686988;4793.856184314476;1690.0167900690753;1896.459509039917;1908.8091190881078;1923.5282661779547;1942.3978566644385;457.0675821324461;469.75572702195353;816.7468084893702;942.4345392764424;963.9325247232626;10195.694129176136;10712.196585256137;10889.673309800719;10927.617533386294;11011.889881101246;481.1387616167092;489.13667377079486;492.55669897092184;504.15805604639604;514.6474664854512;5797.768089276382;6025.3974602540275;6032.306284777219;6054.122152287893;9638.855417168748;314244;358280;362520;367736;368933;69535;78467;79544.60227698824;79627;82300.58849705714;1046.7644779924608;1070.9518071686794;1080.4765280953818;1083.3987137138806;1093.1528065748948;15594.347298693812;15600.765988510408;15666.764704416422;15781.368745250062;15985.68028639444;34246.315073697886;34353;35063.47404788879;35231.11922201965;35416;46382.53617463782;49615;49726;49737.502624973284;49991.50008500014;8095.311898488459;8156.347492200491;8206;8242.546659933761;8423.326133909395;12017.158798884344;12325.506979721069;12759.553415630407;12822.294773787531;13124.475020999053;9970.850437243593;10061.798764024825;10204.846927295948;10365.294313070955;10527.315724477885;6608.537402381787;10730.785384292114;11041.889581104086;11131.610393636183;11254.662360129209;10296.794064118825;10320.587176512856;10414.427206503411;10476.16190704757;10487.161027117965;8196.59017049157;8292.04641466239;8308.958455207685;8369.163083691825;8389.370797190113;8068.394870384627;9241.722748317561;10278.588856445958;10368.610697994798;10384.117350025332 12:36:29 INFO - PROCESS | 24829 | |3;mootools.html;1485.9182744949037;1609.1954022988505;1626.5933516620844;1819.8544116470675;1865.8134186581335;7386.704531818727;8009.839803203932;8053.959730201341;8089.433739638228;8167.673293068277;7887.447878648482;8123.2282933121405;8132.390070744703;8142.91857081429;8152.144024877377;2435.5981263091567;2457.2382561405934;2461.2985299189736;2462.310553045141;2463.2979600813774;2404.1367939846673;2514.270861450186;2514.572522671141;2518.28228954747;2537.3529749913746;2420.1408499982517;2437.013009731053;2480.702315722116;2481.268025932345;2482.118847809029;2458.7787099160983;2470.4318006858434;2481.801455883525;2486.490269494749;2495.201535508638;2319.452816371676;2322.976770232293;2331.3355693627236;2335.381124002141;2475.987620061906;8404.789880252982;8471.279941205004;8474.872876906851;8481.194286542768;8483.15168483153;4983.875403114915;5134.460881607415;5146.228065790124;5147.510986456281;5150.61370397218;3144.5754823099046;3145.276586385144;3169.556262123305;3183.188286986827;3215.3730022645595;1007.450939238117;1018.4093225929017;1028.0439191551854;1040.3185913226848;1059.1632610237903;11085.667429977113;11116.888831111586;11149.21955463118;11155.219134660578;11161.49773260197;4494.865154045384;4505.954940450619;4589.2657174851865;4650.883727906762;4656.8602941911795;9616.423014619146;9653.806923861483;9688.176504997013;9692.079252471003;9720.31957762964;4939.53074457926;4969.527894849984;4971.37857767779;4979.800807967641;4990.3762029746285;4114.629683328515;4494.393256910275;4643.141018911512;4663.580277775017;4668.11305851887;3968.583298753647;4010.0977280111742;4021.1756589899;4032.1330913853662;4073.7759423231414;1252.1235135405252;1260.7730608490376;1260.7982722764498;1276.3554405025588;1289.071868254855;1496.865282124614;1503.691743192643;1505.6762795998693;1515.3105337071606;1541.6608346163825;8067.233612806774;8120.187981201951;8136.7152149674475;8143.714969976022;8148.388870834711;537.8601563593415;538.3943064052941;543.9646422982494;548.6899901555608;553.0818840724378;6220.34686357935;6227.750889964442;6235.189425374672;6266.68666566679;6308.211473565804;9926.15627671656;9991.850122248172;10107.69676909694;10309.84535231972;10314.948425257975;9967.850482242773;10033.548490317953;10148.086672199537;10178.440185789705;10181.898181018243;8075.798105047304;8080.71717489885;8137.471064380915;8148.388870834711;8150.98112735908;7671.69313227487;7745;7797.181295963842;7830.373570114263;7862.371010319046;8604.698835540727;8694.695685651224;9027.322950778587;9261.490618016074;9344.112309330603;8952.910470895467;9040.457572545669;9085.682001129928;9390.95304523473;9490.810183796424;6577.3422657733845;6771.0182023607285;7076.540024898365;7152.642367881689;7221.53060051095;7863.488873223451;7872.803179920548;7891.210878912063;7891.605419729105;7942.563159026309;7041.788746337618;7180.246074162346;7260.600666963156;7318.743843965436;7379.557226566423;7076.186238582423;7094.964525177341;7156.248593897774;7159.785206443815;7174.784756457315;7337.926620733724;7476.327130558276;7476.775696729107;7486.064241969754;7687.961560192163;6942.201646810681;7043.471739619651;7046.647667616496;7051.753188638579;7073;6639.634820084942;6778.186617605722;6903.585784852925;6956.826079348057;6958.304169583002 12:36:29 INFO - PROCESS | 24829 | |4;prototype.html;357.9409397449421;360.2974200309394;365.50656613571675;366.8312576214941;369.5528410623146;5996.970015149924;5997.220361353024;6004.609700369473;6007.128966299884;6057.485113765324;5699.2306038684765;5826.563007774424;5840.941590584093;5980.312264089631;5987.850303742409;4676.275177347517;4678;4682.742449165295;4685.531446855304;4694.976525117387;4499.662525310615;4697.765111744399;4706.858794236161;4707.38803955487;4714.434267887858;4540.523245059271;4625.236835922069;4627.745473998929;4644.6516511261625;4650.023495066041;4651.511591282901;4665.300204969265;4679.74261415622;4685;4693.20215563355;4154.833806647731;4156.937645935313;4161.4382058422025;4166.749995000279;4187.392828039948;5679.290088738908;5684.37471878093;5688.687122208277;5688.857778555569;5698.145278208261;5453;5457.781688732446;5457.836264912019;5460.453954604547;5469.316335458067;6225.87548249037;6349.111124442582;6372.490200783926;6374.298827129012;6376.330485299023;4578.175928332898;4589.1968905441745;4594.793234304464;4604.815807367701;4611.953880461219;6613;6616.636085015322;6621.470282377446;6622.73509059637;6624.205095388585;4699.882502937386;4715.056988602293;4715.504871988461;4716.434027916672;4720.622350212044;4773.594244489257;4777.95222047782;4778;4781.330613714083;4782.234842425195;5295.417504074549;5428.6199966002005;5431.755570999315;5437;5440.6735595864375;6377.5216858735785;6407.903881441782;6412.935870641327;6417.614943103429;6426.036094585849;1609.4527860527478;1663.5757881740321;1676.3043337015247;1684.115839184438;1696.9745453818202;1160.3096157786104;1165.347405452949;1171.7715045566033;1182.3556161891618;1186.6795965089377;6014.398560144038;6020.909686354708;6040.335563088057;6071.605345652607;6086.147939288503;6517.250516190604;6522.347765223534;6526.967365163238;6529.902051469232;6539.019147127969;6098.603590766675;6102.084687296941;6105.32841387447;6106.877862442726;6110.083487476914;3492.318997795456;3521.735869809723;3522.577290725078;3527.664871837171;3533.734969877218;6544.181977252843;6698.363655452724;6707.429868461236;6721.428678562377;6725.495587830932;6624.86750264992;6640.236372817091;6651.16860392451;6652.866942661217;6664.8000559983275;6677.499187560952;6679.532432729759;6687.331266873371;6687.531872768956;6692.5984440932725;6486.578372405778;6490.448311893542;6498.220213574401;6504.15445992018;6507.414332710079;6260.780872669435;6394.648294343856;6412.262589802046;6418.101465794886;6426.678666066771;6673.099131617169;6686.331366863469;6700.195976482853;6704.329567043256;6762.932370676427;4687.835925742719;4692.460367057832;4697.577218050392;4698.718076915396;4698.765061746831;6290.150829637941;6456.289808121009;6473.287938326875;6481.740730370921;6495.74017039332;6445.581037232565;6449.193850768654;6450.129232553545;6455.193100862392;6463.838404039937;6442;6442.903356449563;6444.581102228528;6450.838729031811;6461.19235095613;6328.936710633019;6330.3669633036325;6331.525135614939;6333.524985626004;6337.271213810471;6262.780802671885;6463.15978922737;6465.030245463218;6474.223093228843;6485.319041500575;6282.623042617458;6315.115883776183;6332.398422149889;6337.397947195193;6344.492440604648 12:36:29 INFO - PROCESS | 24829 | |5;yui.html;799.3964556759646;843.8143608406149;881.2993670032324;887.6715615222367;898.1691934960161;14575.34410951507;14941;15290.46483373082;15390.230488475587;15427.69144617107;13949.860501394984;13969.860301396982;13988.790168147487;14035.228062456561;14048.71902561948;768.2317682317682;773.9883901741479;904.145582424609;918.6233644205877;919.9632014719404;916.1662886773038;923.422860712055;924.8474001789697;925.5233554719291;927.5686805635378;804.5494523067072;954.3033585482602;963.8698775665266;964.0552258786394;964.1419136968069;941.1529623338981;952.2049089010684;953.3850666320254;954.0697819625879;954.8376775948071;695.051255036871;701.491418721428;702.5819637315789;705.1819888928869;705.5378726933867;14477.276136193253;14624.707505849823;14648.047876887968;14656.193909334983;14772.852271477255;13731.519396821162;13860.237686927216;13879.653008674763;13967.79048314276;14412.783808242884;11232.719182020433;11365.261258018203;11955.05796647728;12180.451879665436;12278.754424911453;3999.260136874658;4023.7786921719294;4040.7575545467366;4056.553779084298;4158.064435502018;48953.510464895255;49217;50622.746886265704;51109.48890511085;51276;10717.624883129052;10725.14198864089;10858.94570527158;10872.45637718111;11014.229003969805;18722.157502912403;18748.906255468635;18754.812451875307;18786.812131878505;19033.857968521657;7845.803854903673;7882.566458844819;7900.407469439815;7968.920310796933;7981.960090199512;4635.351050852883;4672.95327046732;4685.718856868599;4699.624030077585;4722.386089808371;3204.951925721116;3350.0619826448633;3365.74756893234;3366.8316584170693;3395.168183794986;624.7657128576784;654.9770758023446;665.6804733727838;672.9528932974742;673.952823302374;595.833166713321;647.5726020826232;659.0016125569765;712.6045045000075;727.385359371341;9236.261099112055;9831.9016809831;10011.59529449076;10018.849717254247;10184.388936663823;750.557171268954;766.3486036868728;766.371575308253;779.3842864137268;795.7095660084143;4269.466316710411;4494.5730155635165;4497.078098989765;4504.729716217037;4552.499225085238;56371.436285637436;57197;57407.13889291664;57826.4217357821;58297;51817.48182518202;52197.7390113047;52334.73832630813;52561.73719131456;52798.20802687963;45479.772601136785;46408.303875441896;46524.5347546527;46776;47134.29298560524;8620.267277281502;8663.523506207219;8760.386772925835;8991.325650576102;9615.855762163714;35557.28885422329;35879.46180807342;36321.27357452783;38258.42612360761;38413.423798642485;42774.78612606917;43512;43536.346954795066;44460.55539444564;45297.77351113223;12224.083193760682;12277.938610306892;12412.069094817743;12504.124711270124;12606.87393126057;13095.476180952655;13285.335733213107;13453.730925381242;13490.258035808125;13925.373358199107;11305.491252893475;11630.53477860876;12186.6953326164;12331.938340308241;12831.909287710649;11547.364894930859;11835.881641183822;12523;12801.231926084465;13338;11225.71935701614;11534;11670.649880503599;11769.764604708029;12112;10421.843672345072;10523.4738263085;10569.260151789302;10726.356418614909;10859.309224783428;9108.453492790453;9237.399569027992;9362.625494980397;9380.390274632127;9434.575444105169 12:36:29 INFO - PROCESS | 24829 | __end_tp_report 12:36:29 INFO - PROCESS | 24829 | __start_cc_report 12:36:29 INFO - PROCESS | 24829 | _x_x_mozilla_cycle_collect,681 12:36:29 INFO - PROCESS | 24829 | __end_cc_report 12:36:29 INFO - PROCESS | 24829 | __startTimestamp1456950989549__endTimestamp 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | ------- Summary: start ------- 12:36:29 INFO - PROCESS | 24829 | Number of tests: 6 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | [#0] dojo.html Cycles:165 Average:5296.26 Median:5524.92 stddev:577.51 (10.5%) stddev-sans-first:555.73 12:36:29 INFO - PROCESS | 24829 | Values: 3215.3 3260.7 3290.0 3295.3 3324.9 5264.9 5283.3 5287.8 5303.3 5329.1 5288.5 5296.1 5327.4 5339.2 5340.1 4762.6 4833.9 4914.2 4926.2 4969.1 4785.9 4849.8 4850.9 4852.1 4857.9 4843.6 4893.0 4897.1 4901.6 4949.1 4376.7 4879.0 4896.1 4908.2 4911.9 4760.5 4835.5 4838.9 4872.5 4881.5 5166.4 5191.3 5199.6 5210.7 5213.3 5512.6 5644.6 5713.5 5722.7 5726.7 5729.1 5730.0 5730.1 5743.2 5748.9 5401.9 5402.8 5407.9 5408.7 5412.1 5663.4 5720.1 5731.8 5771.9 5809.2 5606.3 5607.5 5607.9 5619.4 5622.0 5560.4 5688.8 5692.8 5708.7 5719.5 5699.3 5704.7 5707.1 5710.8 5761.9 5707.1 5709.3 5710.2 5710.3 5715.2 4256.4 4324.5 4360.0 4408.4 4410.3 3898.9 3909.7 3910.3 3928.8 3933.7 5292.3 5305.7 5309.5 5331.5 5331.6 5594.8 5617.7 5671.0 5697.7 5726.3 5379.5 5386.1 5410.8 5453.8 5455.9 4880.0 4882.4 4888.9 4898.2 4923.7 5865.4 5898.7 5903.3 5907.4 5945.0 5558.6 5594.7 5657.6 5666.2 5836.2 5827.3 5854.2 5886.3 5915.6 5932.3 5629.0 5629.5 5630.7 5633.6 5638.1 5694.0 5694.7 5700.5 5707.9 5708.9 5452.8 5574.5 5646.1 5659.7 5674.7 5556.8 5561.8 5562.9 5564.7 5574.3 5369.5 5446.7 5503.5 5508.9 5528.1 5630.7 5652.3 5683.0 5691.7 5693.8 5520.3 5524.9 5541.2 5542.8 5548.8 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | [#1] ext.html Cycles:180 Average:52194.73 Median:411168.00 stddev:90036.20 (21.9%) stddev-sans-first:90205.19 12:36:29 INFO - PROCESS | 24829 | Values: 521.6 556.9 557.4 580.9 593.0 30564.2 38718.4 39076.4 39093.4 39120.0 42439.2 42913.8 43040.1 43058.8 43068.0 8753.2 8925.0 8948.4 8963.9 8967.2 8829.1 8971.4 8979.7 8981.6 9236.2 9171.5 9244.4 9264.3 9268.4 9272.7 9143.1 9233.6 9234.3 9235.2 9236.6 9026.4 9108.3 9128.3 9149.0 9151.0 41501.6 42008.8 42031.0 42068.8 42097.0 3505.9 3676.8 3828.7 4211.6 4728.1 28762.6 29163.0 29367.6 29372.0 29822.1 3651.4 4230.5 4314.2 4330.8 4351.4 297022.0 300354.0 300693.0 300720.0 341817.0 59825.4 60257.0 60372.4 60580.4 60584.4 65289.7 65500.7 65549.0 65645.0 65652.7 16012.0 16236.2 16237.7 16254.3 16269.2 11424.3 11565.0 11653.1 11682.9 11707.5 22345.7 22465.7 22476.2 22481.8 22496.9 8683.6 8721.6 8733.0 8749.3 8754.2 1062.1 1113.3 1145.4 1156.6 1167.4 27322.2 32164.7 32498.7 32760.0 33063.2 1008.1 1086.7 1120.2 1149.1 1197.4 14556.8 14740.6 15143.5 15226.3 16709.9 408117.0 410678.0 411658.0 413100.0 415974.0 56908.4 56961.0 57003.7 57217.4 57240.7 1494.2 1494.7 1494.9 1503.0 1507.4 30286.5 30360.8 30521.2 30985.7 31002.5 47659.0 48185.8 48333.3 48379.5 48422.0 295715.0 296214.0 297852.0 297994.0 298033.0 28969.3 35530.3 35609.8 35627.5 36107.0 54579.7 55130.1 58963.0 59422.0 60490.7 38911.2 39680.2 44025.3 44193.0 45915.3 39246.8 40449.4 40480.2 43403.0 44008.8 41347.4 41533.4 42201.0 42263.8 42733.7 37547.8 37660.6 38428.8 38721.6 38747.2 28049.6 28413.0 28501.7 28599.6 28709.1 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | [#2] jquery.html Cycles:180 Average:23197.79 Median:184654.72 stddev:58716.44 (31.8%) stddev-sans-first:58856.15 12:36:29 INFO - PROCESS | 24829 | Values: 376.4 378.1 382.3 384.7 385.6 14547.4 14908.0 17262.3 17280.7 17839.5 16594.6 16740.0 17142.0 18096.5 18102.4 5501.0 5516.3 5693.0 5706.5 5730.6 4151.7 5618.3 5958.3 6199.2 6214.7 6147.7 6149.2 6155.8 6171.7 6174.9 5934.7 6253.5 6263.2 6275.4 6276.1 5479.7 5521.1 5521.7 5546.1 5548.7 20637.6 20998.7 21139.0 21159.0 21195.3 1918.9 1927.6 2064.9 2231.0 2448.6 13536.7 13543.5 13656.2 13739.2 14142.5 1962.3 2055.6 2056.7 2056.9 2071.8 63350.4 63685.7 64038.7 64077.0 66267.4 10339.0 10865.7 10947.2 10963.1 11017.6 14357.6 14384.5 14504.4 14505.1 14509.4 7803.0 7903.5 7912.1 7940.8 7964.2 7585.4 7609.8 7624.7 7646.7 7653.2 4691.4 4754.9 4766.5 4774.4 4793.9 1690.0 1896.5 1908.8 1923.5 1942.4 457.1 469.8 816.7 942.4 963.9 10195.7 10712.2 10889.7 10927.6 11011.9 481.1 489.1 492.6 504.2 514.6 5797.8 6025.4 6032.3 6054.1 9638.9 314244.0 358280.0 362520.0 367736.0 368933.0 69535.0 78467.0 79544.6 79627.0 82300.6 1046.8 1071.0 1080.5 1083.4 1093.2 15594.3 15600.8 15666.8 15781.4 15985.7 34246.3 34353.0 35063.5 35231.1 35416.0 46382.5 49615.0 49726.0 49737.5 49991.5 8095.3 8156.3 8206.0 8242.5 8423.3 12017.2 12325.5 12759.6 12822.3 13124.5 9970.9 10061.8 10204.8 10365.3 10527.3 6608.5 10730.8 11041.9 11131.6 11254.7 10296.8 10320.6 10414.4 10476.2 10487.2 8196.6 8292.0 8309.0 8369.2 8389.4 8068.4 9241.7 10278.6 10368.6 10384.1 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | [#3] mootools.html Cycles:180 Average:5812.12 Median:550.89 stddev:3019.62 (548.1%) stddev-sans-first:3010.58 12:36:29 INFO - PROCESS | 24829 | Values: 1485.9 1609.2 1626.6 1819.9 1865.8 7386.7 8009.8 8054.0 8089.4 8167.7 7887.4 8123.2 8132.4 8142.9 8152.1 2435.6 2457.2 2461.3 2462.3 2463.3 2404.1 2514.3 2514.6 2518.3 2537.4 2420.1 2437.0 2480.7 2481.3 2482.1 2458.8 2470.4 2481.8 2486.5 2495.2 2319.5 2323.0 2331.3 2335.4 2476.0 8404.8 8471.3 8474.9 8481.2 8483.2 4983.9 5134.5 5146.2 5147.5 5150.6 3144.6 3145.3 3169.6 3183.2 3215.4 1007.5 1018.4 1028.0 1040.3 1059.2 11085.7 11116.9 11149.2 11155.2 11161.5 4494.9 4506.0 4589.3 4650.9 4656.9 9616.4 9653.8 9688.2 9692.1 9720.3 4939.5 4969.5 4971.4 4979.8 4990.4 4114.6 4494.4 4643.1 4663.6 4668.1 3968.6 4010.1 4021.2 4032.1 4073.8 1252.1 1260.8 1260.8 1276.4 1289.1 1496.9 1503.7 1505.7 1515.3 1541.7 8067.2 8120.2 8136.7 8143.7 8148.4 537.9 538.4 544.0 548.7 553.1 6220.3 6227.8 6235.2 6266.7 6308.2 9926.2 9991.9 10107.7 10309.8 10314.9 9967.9 10033.5 10148.1 10178.4 10181.9 8075.8 8080.7 8137.5 8148.4 8151.0 7671.7 7745.0 7797.2 7830.4 7862.4 8604.7 8694.7 9027.3 9261.5 9344.1 8952.9 9040.5 9085.7 9391.0 9490.8 6577.3 6771.0 7076.5 7152.6 7221.5 7863.5 7872.8 7891.2 7891.6 7942.6 7041.8 7180.2 7260.6 7318.7 7379.6 7076.2 7095.0 7156.2 7159.8 7174.8 7337.9 7476.3 7476.8 7486.1 7688.0 6942.2 7043.5 7046.6 7051.8 7073.0 6639.6 6778.2 6903.6 6956.8 6958.3 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | [#4] prototype.html Cycles:180 Average:5355.95 Median:6030.62 stddev:1562.84 (25.9%) stddev-sans-first:1521.54 12:36:29 INFO - PROCESS | 24829 | Values: 357.9 360.3 365.5 366.8 369.6 5997.0 5997.2 6004.6 6007.1 6057.5 5699.2 5826.6 5840.9 5980.3 5987.9 4676.3 4678.0 4682.7 4685.5 4695.0 4499.7 4697.8 4706.9 4707.4 4714.4 4540.5 4625.2 4627.7 4644.7 4650.0 4651.5 4665.3 4679.7 4685.0 4693.2 4154.8 4156.9 4161.4 4166.7 4187.4 5679.3 5684.4 5688.7 5688.9 5698.1 5453.0 5457.8 5457.8 5460.5 5469.3 6225.9 6349.1 6372.5 6374.3 6376.3 4578.2 4589.2 4594.8 4604.8 4612.0 6613.0 6616.6 6621.5 6622.7 6624.2 4699.9 4715.1 4715.5 4716.4 4720.6 4773.6 4778.0 4778.0 4781.3 4782.2 5295.4 5428.6 5431.8 5437.0 5440.7 6377.5 6407.9 6412.9 6417.6 6426.0 1609.5 1663.6 1676.3 1684.1 1697.0 1160.3 1165.3 1171.8 1182.4 1186.7 6014.4 6020.9 6040.3 6071.6 6086.1 6517.3 6522.3 6527.0 6529.9 6539.0 6098.6 6102.1 6105.3 6106.9 6110.1 3492.3 3521.7 3522.6 3527.7 3533.7 6544.2 6698.4 6707.4 6721.4 6725.5 6624.9 6640.2 6651.2 6652.9 6664.8 6677.5 6679.5 6687.3 6687.5 6692.6 6486.6 6490.4 6498.2 6504.2 6507.4 6260.8 6394.6 6412.3 6418.1 6426.7 6673.1 6686.3 6700.2 6704.3 6762.9 4687.8 4692.5 4697.6 4698.7 4698.8 6290.2 6456.3 6473.3 6481.7 6495.7 6445.6 6449.2 6450.1 6455.2 6463.8 6442.0 6442.9 6444.6 6450.8 6461.2 6328.9 6330.4 6331.5 6333.5 6337.3 6262.8 6463.2 6465.0 6474.2 6485.3 6282.6 6315.1 6332.4 6337.4 6344.5 12:36:29 INFO - PROCESS | 24829 | 12:36:29 INFO - PROCESS | 24829 | [#5] yui.html Cycles:180 Average:14414.40 Median:24901.25 stddev:16085.87 (64.6%) stddev-sans-first:16098.50 12:36:29 INFO - PROCESS | 24829 | Values: 799.4 843.8 881.3 887.7 898.2 14575.3 14941.0 15290.5 15390.2 15427.7 13949.9 13969.9 13988.8 14035.2 14048.7 768.2 774.0 904.1 918.6 920.0 916.2 923.4 924.8 925.5 927.6 804.5 954.3 963.9 964.1 964.1 941.2 952.2 953.4 954.1 954.8 695.1 701.5 702.6 705.2 705.5 14477.3 14624.7 14648.0 14656.2 14772.9 13731.5 13860.2 13879.7 13967.8 14412.8 11232.7 11365.3 11955.1 12180.5 12278.8 3999.3 4023.8 4040.8 4056.6 4158.1 48953.5 49217.0 50622.7 51109.5 51276.0 10717.6 10725.1 10858.9 10872.5 11014.2 18722.2 18748.9 18754.8 18786.8 19033.9 7845.8 7882.6 7900.4 7968.9 7982.0 4635.4 4673.0 4685.7 4699.6 4722.4 3205.0 3350.1 3365.7 3366.8 3395.2 624.8 655.0 665.7 673.0 674.0 595.8 647.6 659.0 712.6 727.4 9236.3 9831.9 10011.6 10018.8 10184.4 750.6 766.3 766.4 779.4 795.7 4269.5 4494.6 4497.1 4504.7 4552.5 56371.4 57197.0 57407.1 57826.4 58297.0 51817.5 52197.7 52334.7 52561.7 52798.2 45479.8 46408.3 46524.5 46776.0 47134.3 8620.3 8663.5 8760.4 8991.3 9615.9 35557.3 35879.5 36321.3 38258.4 38413.4 42774.8 43512.0 43536.3 44460.6 45297.8 12224.1 12277.9 12412.1 12504.1 12606.9 13095.5 13285.3 13453.7 13490.3 13925.4 11305.5 11630.5 12186.7 12331.9 12831.9 11547.4 11835.9 12523.0 12801.2 13338.0 11225.7 11534.0 11670.6 11769.8 12112.0 10421.8 10523.5 10569.3 10726.4 10859.3 9108.5 9237.4 9362.6 9380.4 9434.6 12:36:29 INFO - PROCESS | 24829 | -------- Summary: end -------- 12:36:29 INFO - PROCESS | 24829 | 12:36:30 INFO - TEST-INFO | 24829: exit 0 12:36:30 INFO - TEST-OK | dromaeo_css | took 1111267ms 12:36:30 INFO - TEST-START | kraken 12:36:30 INFO - operating with platform_type : linux_ 12:36:30 INFO - Initialising browser for kraken test... 12:36:30 INFO - TEST-INFO | started process 25023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcCJJ0/profile http://localhost:54238/getInfo.html) 12:36:34 INFO - PROCESS | 25023 | __metrics Screen width/height:1600/1200 12:36:34 INFO - PROCESS | 25023 | colorDepth:24 12:36:34 INFO - PROCESS | 25023 | Browser inner width/height: 1024/697 12:36:34 INFO - PROCESS | 25023 | __metrics 12:36:35 INFO - PROCESS | 25023 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:36 INFO - TEST-INFO | 25023: exit 0 12:36:36 INFO - Browser initialized. 12:36:36 INFO - Running cycle 1/1 for kraken test... 12:36:36 INFO - TEST-INFO | started process 25114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcCJJ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:47 INFO - PROCESS | 25114 | RSS: Main: 133124096 12:36:47 INFO - PROCESS | 25114 | 12:36:50 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54238/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:50 INFO - PROCESS | 25114 | RSS: Main: 172822528 12:36:50 INFO - PROCESS | 25114 | 12:36:53 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54238/tests/kraken/driver.html?testName=audio-dft) 12:36:54 INFO - PROCESS | 25114 | RSS: Main: 169484288 12:36:54 INFO - PROCESS | 25114 | 12:36:56 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54238/tests/kraken/driver.html?testName=audio-fft) 12:36:57 INFO - PROCESS | 25114 | RSS: Main: 167653376 12:36:57 INFO - PROCESS | 25114 | 12:36:59 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54238/tests/kraken/driver.html?testName=audio-oscillator) 12:37:00 INFO - PROCESS | 25114 | RSS: Main: 167325696 12:37:00 INFO - PROCESS | 25114 | 12:37:02 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:02 INFO - PROCESS | 25114 | RSS: Main: 168017920 12:37:02 INFO - PROCESS | 25114 | 12:37:05 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54238/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:06 INFO - PROCESS | 25114 | RSS: Main: 165683200 12:37:06 INFO - PROCESS | 25114 | 12:37:09 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54238/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:10 INFO - PROCESS | 25114 | RSS: Main: 168472576 12:37:10 INFO - PROCESS | 25114 | 12:37:13 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54238/tests/kraken/driver.html?testName=json-parse-financial) 12:37:13 INFO - PROCESS | 25114 | RSS: Main: 167419904 12:37:13 INFO - PROCESS | 25114 | 12:37:15 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:15 INFO - PROCESS | 25114 | RSS: Main: 171741184 12:37:15 INFO - PROCESS | 25114 | 12:37:17 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:18 INFO - PROCESS | 25114 | RSS: Main: 169533440 12:37:18 INFO - PROCESS | 25114 | 12:37:20 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:20 INFO - PROCESS | 25114 | RSS: Main: 179146752 12:37:20 INFO - PROCESS | 25114 | 12:37:23 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:23 INFO - PROCESS | 25114 | RSS: Main: 183336960 12:37:23 INFO - PROCESS | 25114 | 12:37:26 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:26 INFO - PROCESS | 25114 | RSS: Main: 180891648 12:37:26 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | Cycle 1(1): loaded http://localhost:54238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54238/tests/kraken/driver.html?testName=ai-astar) 12:37:28 INFO - PROCESS | 25114 | RSS: Main: 242253824 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | __start_tp_report 12:37:28 INFO - PROCESS | 25114 | _x_x_mozilla_page_load 12:37:28 INFO - PROCESS | 25114 | _x_x_mozilla_page_load_details 12:37:28 INFO - PROCESS | 25114 | |i|pagename|runs| 12:37:28 INFO - PROCESS | 25114 | |0;ai-astar;109;112;107;112;112;113;100;110;110;111 12:37:28 INFO - PROCESS | 25114 | |1;audio-beat-detection;157;135;149;168;124;150;150;127;174;124 12:37:28 INFO - PROCESS | 25114 | |2;audio-dft;161;162;160;160;161;161;159;163;162;161 12:37:28 INFO - PROCESS | 25114 | |3;audio-fft;83;73;74;154;75;74;74;76;155;73 12:37:28 INFO - PROCESS | 25114 | |4;audio-oscillator;95;96;139;95;95;95;144;96;95;138 12:37:28 INFO - PROCESS | 25114 | |5;imaging-gaussian-blur;119;115;114;114;115;115;115;114;115;115 12:37:28 INFO - PROCESS | 25114 | |6;imaging-darkroom;146;146;145;146;146;145;146;146;146;146 12:37:28 INFO - PROCESS | 25114 | |7;imaging-desaturate;96;95;96;95;96;95;96;96;96;96 12:37:28 INFO - PROCESS | 25114 | |8;json-parse-financial;53;54;62;54;54;55;53;54;53;53 12:37:28 INFO - PROCESS | 25114 | |9;json-stringify-tinderbox;64;65;64;65;65;64;64;65;65;65 12:37:28 INFO - PROCESS | 25114 | |10;stanford-crypto-aes;78;79;80;81;81;78;79;78;79;78 12:37:28 INFO - PROCESS | 25114 | |11;stanford-crypto-ccm;115;118;117;113;110;116;118;119;127;119 12:37:28 INFO - PROCESS | 25114 | |12;stanford-crypto-pbkdf2;148;145;157;140;134;132;150;146;142;148 12:37:28 INFO - PROCESS | 25114 | |13;stanford-crypto-sha256-iterative;68;68;71;67;66;68;66;70;66;67 12:37:28 INFO - PROCESS | 25114 | __end_tp_report 12:37:28 INFO - PROCESS | 25114 | __start_cc_report 12:37:28 INFO - PROCESS | 25114 | _x_x_mozilla_cycle_collect,933 12:37:28 INFO - PROCESS | 25114 | __end_cc_report 12:37:28 INFO - PROCESS | 25114 | __startTimestamp1456951048714__endTimestamp 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | ------- Summary: start ------- 12:37:28 INFO - PROCESS | 25114 | Number of tests: 14 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:3.81 (3.4%) stddev-sans-first:4.03 12:37:28 INFO - PROCESS | 25114 | Values: 109.0 112.0 107.0 112.0 112.0 113.0 100.0 110.0 110.0 111.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:150.00 stddev:17.89 (11.9%) stddev-sans-first:18.51 12:37:28 INFO - PROCESS | 25114 | Values: 157.0 135.0 149.0 168.0 124.0 150.0 150.0 127.0 174.0 124.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 12:37:28 INFO - PROCESS | 25114 | Values: 161.0 162.0 160.0 160.0 161.0 161.0 159.0 163.0 162.0 161.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#3] audio-fft Cycles:10 Average:91.10 Median:74.00 stddev:33.54 (45.3%) stddev-sans-first:35.45 12:37:28 INFO - PROCESS | 25114 | Values: 83.0 73.0 74.0 154.0 75.0 74.0 74.0 76.0 155.0 73.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.00 stddev:21.82 (23.0%) stddev-sans-first:22.56 12:37:28 INFO - PROCESS | 25114 | Values: 95.0 96.0 139.0 95.0 95.0 95.0 144.0 96.0 95.0 138.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.45 (1.3%) stddev-sans-first:0.50 12:37:28 INFO - PROCESS | 25114 | Values: 119.0 115.0 114.0 114.0 115.0 115.0 115.0 114.0 115.0 115.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 12:37:28 INFO - PROCESS | 25114 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:37:28 INFO - PROCESS | 25114 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:2.72 (5.0%) stddev-sans-first:2.83 12:37:28 INFO - PROCESS | 25114 | Values: 53.0 54.0 62.0 54.0 54.0 55.0 53.0 54.0 53.0 53.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 12:37:28 INFO - PROCESS | 25114 | Values: 64.0 65.0 64.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:1.20 (1.5%) stddev-sans-first:1.20 12:37:28 INFO - PROCESS | 25114 | Values: 78.0 79.0 80.0 81.0 81.0 78.0 79.0 78.0 79.0 78.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:118.00 stddev:4.47 (3.8%) stddev-sans-first:4.67 12:37:28 INFO - PROCESS | 25114 | Values: 115.0 118.0 117.0 113.0 110.0 116.0 118.0 119.0 127.0 119.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:147.00 stddev:7.50 (5.1%) stddev-sans-first:7.82 12:37:28 INFO - PROCESS | 25114 | Values: 148.0 145.0 157.0 140.0 134.0 132.0 150.0 146.0 142.0 148.0 12:37:28 INFO - PROCESS | 25114 | 12:37:28 INFO - PROCESS | 25114 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 12:37:28 INFO - PROCESS | 25114 | Values: 68.0 68.0 71.0 67.0 66.0 68.0 66.0 70.0 66.0 67.0 12:37:28 INFO - PROCESS | 25114 | -------- Summary: end -------- 12:37:28 INFO - PROCESS | 25114 | 12:37:29 INFO - TEST-INFO | 25114: exit 0 12:37:29 INFO - TEST-OK | kraken | took 59364ms 12:37:29 INFO - SUITE-END | took 1170s 12:37:29 INFO - Completed test suite (00:19:30) 12:37:29 INFO - Working with test: dromaeo_css 12:37:29 INFO - Generating results file: dromaeo_css 12:37:29 INFO - Working with test: kraken 12:37:29 INFO - Generating results file: kraken 12:37:29 INFO - javascript benchmark 12:37:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,181,35]] 12:37:29 INFO - process_Request line: dromaeo_css 7167.44 graph.html#tests=[[72,181,35]] 12:37:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:29 INFO - process_Request line: kraken 1500.20 graph.html#tests=[[232,181,35]] 12:37:29 INFO - RETURN: dromaeo_css: 7167.44 12:37:29 INFO - RETURN: kraken: 1500.20 12:37:29 INFO - javascript benchmark 12:37:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3215.340855124699, 3260.6576309487486, 3290.0294413148135, 3295.2585668224638, 3324.850381732822, 5264.947350526493, 5283.313169287992, 5287.814926477574, 5303.337082864642, 5329.094054010813, 5288.497592728694, 5296.09966305728, 5327.36071671399, 5339.199120131982, 5340.0654885395, 4762.618990480771, 4833.903321933559, 4914.164592019356, 4926.162552366106, 4969.055879382924, 4785.904281914377, 4849.806007759686, 4850.854474365757, 4852.102361063197, 4857.854264372057, 4843.564079232869, 4892.951070489303, 4897.142999975008, 4901.583365413944, 4949.133901567229, 4376.715513491613, 4879.048585525824, 4896.143174944388, 4908.214685650279, 4911.852644420673, 4760.523947605212, 4835.516448355136, 4838.903221935577, 4872.4640289568115, 4881.51184881509, 5166.380034395859, 5191.325127733408, 5199.558037566811, 5210.713410762407, 5213.322268105122, 5512.641678290898, 5644.6330988486025, 5713.514351280146, 5722.713864306768, 5726.713664316768, 5729.1119876419225, 5729.9713501432225, 5730.05454100073, 5743.16724075011, 5748.913766293509, 5401.918971215396, 5402.756875940592, 5407.891842163135, 5408.729563521848, 5412.07994640912, 5663.405342439067, 5720.056190728483, 5731.799387021434, 5771.85570360736, 5809.244798176294, 5606.327240731139, 5607.495325420732, 5607.8598035048635, 5619.381867994517, 5622.044252477089, 5560.360558535739, 5688.800891968844, 5692.800751973661, 5708.686022268815, 5719.48524632785, 5699.316082070095, 5704.686242256633, 5707.058335374617, 5710.771569137188, 5761.884762304814, 5707.143928410772, 5709.286339207599, 5710.229119068873, 5710.257666503411, 5715.199872017921, 4256.382824490432, 4324.502682191588, 4359.9782001090425, 4408.404865343137, 4410.250257456176, 3898.922021559553, 3909.6872250219913, 3910.2961466936226, 3928.8035598219976, 3933.7443066200603, 5292.311999440049, 5305.734713264398, 5309.46905309466, 5331.466853314715, 5331.600129990189, 5594.832155035356, 5617.719114044363, 5670.971645141831, 5697.686627235542, 5726.341470730836, 5379.515843574019, 5386.084365657847, 5410.756515956791, 5453.809116680897, 5455.918161227585, 4880.0, 4882.389701287339, 4888.902221955541, 4898.191798353303, 4923.679960802608, 5865.384134665798, 5898.734556944948, 5903.321118071391, 5907.409259074144, 5945.048792193228, 5558.610897237155, 5594.692291923983, 5657.575681823797, 5666.15007748841, 5836.241288632451, 5827.271591051119, 5854.209681692917, 5886.293644762656, 5915.615484993634, 5932.347441781314, 5629.0, 5629.493345598916, 5630.690312032878, 5633.577481688808, 5638.097904335286, 5693.971530142323, 5694.658320500783, 5700.486956173964, 5707.885842283048, 5708.914366284592, 5452.7546260417585, 5574.470425309589, 5646.0683987141665, 5659.688717120598, 5674.716264186856, 5556.833295001156, 5561.833145005657, 5562.860928476659, 5564.749586268708, 5574.303212098488, 5369.5167434931045, 5446.727663616883, 5503.532199762904, 5508.91736623959, 5528.06022976103, 5630.718464076698, 5652.321721393295, 5683.0, 5691.686957217393, 5693.829185124453, 5520.282363292747, 5524.917126243029, 5541.224228607917, 5542.7782888684005, 5548.750306236148], "unit": "score", "name": "dojo.html", "value": 5259.867566607099}, {"lowerIsBetter": false, "replicates": [521.5957632834551, 556.8719194585248, 557.3757391721272, 580.9157672137538, 592.9978336611127, 30564.235894102632, 38718.41922371163, 39076.413853792146, 39093.413598796, 39120.0, 42439.15121697564, 42913.7854310728, 43040.139197216035, 43058.784706076425, 43068.0, 8753.212210901034, 8925.0, 8948.418352807046, 8963.910360896372, 8967.192952634261, 8829.117088291183, 8971.416857904247, 8979.730608081736, 8981.595828187747, 9236.21492173166, 9171.495567743772, 9244.352895297297, 9264.258859291274, 9268.351215414923, 9272.72181834546, 9143.08569143087, 9233.584488698025, 9234.30742694294, 9235.215006724404, 9236.630534778635, 9026.368154229207, 9108.271338292987, 9128.3153763468, 9149.039350868195, 9150.954245228731, 41501.58498415037, 42008.78995605002, 42031.0, 42068.78965605183, 42097.0, 3505.9474107888145, 3676.8161591920298, 3828.712846536521, 4211.557786432411, 4728.05438912219, 28762.568561471595, 29163.0, 29367.55948660772, 29372.0, 29822.10533683993, 3651.434027725707, 4230.51349094855, 4314.158739045887, 4330.805113769888, 4351.369051487517, 297022.0, 300354.0, 300693.0, 300720.0, 341816.9999999975, 59825.401745982854, 60257.0, 60372.39627603668, 60580.394196057474, 60584.394156057875, 65289.67355163194, 65500.672496638166, 65549.0, 65645.0, 65652.67173664196, 16012.0, 16236.188190590423, 16237.675246495004, 16254.268557914686, 16269.18654067292, 11424.314541127558, 11564.95915367621, 11653.067754579613, 11682.883171168349, 11707.531698731955, 22345.664815027787, 22465.663015054786, 22476.213332533283, 22481.775182248297, 22496.887515562317, 8683.565821709015, 8721.60752766127, 8733.0, 8749.343799214957, 8754.21212090915, 1062.0706881478707, 1113.2986218682179, 1145.352875625269, 1156.5836298932377, 1167.416291854073, 27322.180334589597, 32164.678353216637, 32498.675013249565, 32760.0, 33063.17342066419, 1008.1279693065592, 1086.6631344283298, 1120.1878637987395, 1149.149629274331, 1197.3833475759816, 14556.781648275284, 14740.557783266519, 15143.545693628988, 15226.314815833313, 16709.91645041767, 408117.0, 410678.0, 411658.0, 413100.0, 415974.0, 56908.43091569114, 56961.0, 57003.714981424826, 57217.427825721206, 57240.713796431584, 1494.2454060699276, 1494.7160039592661, 1494.9103053816805, 1503.0, 1507.3593722668043, 30286.54570181405, 30360.84819575888, 30521.23696907595, 30985.69014309828, 31002.534961975136, 47659.0, 48185.75907120442, 48333.27500087572, 48379.51620483891, 48422.0, 295715.0, 296214.0, 297852.0, 297994.0, 298033.0, 28969.275768105967, 35530.28939421249, 35609.82195089008, 35627.46558801568, 36107.0, 54579.72710136424, 55130.06175880742, 58963.0, 59422.0, 60490.69754651198, 38911.221775564896, 39680.2063958725, 44025.339619906365, 44193.0, 45915.31127033164, 39246.803765980985, 40449.39325910055, 40480.1903961925, 43403.0, 44008.779956100014, 41347.379789302584, 41533.37699934564, 42201.0, 42263.7886810564, 42733.7179884604, 37547.81226093852, 37660.62339376681, 38428.80785596166, 38721.6127838718, 38747.225055498166, 28049.57925631158, 28413.0, 28501.714982850735, 28599.571006435337, 28709.138725838257], "unit": "score", "name": "ext.html", "value": 20066.61856211672}, {"lowerIsBetter": false, "replicates": [376.4485029431884, 378.1359593329243, 382.2794033247328, 384.74030029729926, 385.63557438220886, 14547.418103275857, 14908.030977986451, 17262.309507619695, 17280.74078888816, 17839.464816055523, 16594.58513537162, 16740.0, 17142.0, 18096.457106286798, 18102.366417175403, 5500.972495137528, 5516.282883225195, 5693.0, 5706.543476521889, 5730.627509211888, 4151.730137541065, 5618.325800903897, 5958.28500579931, 6199.163112979758, 6214.65819379934, 6147.661878596676, 6149.16986206863, 6155.815325540241, 6171.660558669271, 6174.876502469948, 5934.664700442409, 6253.53098517613, 6263.217097862767, 6275.372462753734, 6276.058591211332, 5479.726013699299, 5521.089020311644, 5521.668699878021, 5546.057170281062, 5548.722563871831, 20637.58724825495, 20998.685019724715, 21139.04874280661, 21159.0, 21195.25816596412, 1918.8656794024423, 1927.575933294673, 2064.917403303866, 2230.9514528171735, 2448.5592593333195, 13536.729265414637, 13543.45826166952, 13656.180629162183, 13739.175649461064, 14142.505012324622, 1962.3131903833687, 2055.640262953977, 2056.7120603115577, 2056.856020078595, 2071.7513898332145, 63350.36649633491, 63685.68157159231, 64038.67980660067, 64077.0, 66267.40947075227, 10339.0, 10865.728356791144, 10947.233693641369, 10963.068139208257, 11017.559297628166, 14357.6410589734, 14384.496542621167, 14504.419823206954, 14505.057171283834, 14509.419623214953, 7803.0, 7903.525788452711, 7912.0505539335645, 7940.841183176304, 7964.2433968772875, 7585.355244804143, 7609.809754756065, 7624.656890439944, 7646.732364367332, 7653.234676532414, 4691.366665500182, 4754.9286760698615, 4766.451858036301, 4774.379330686988, 4793.856184314476, 1690.0167900690753, 1896.459509039917, 1908.8091190881078, 1923.5282661779547, 1942.3978566644385, 457.0675821324461, 469.75572702195353, 816.7468084893702, 942.4345392764424, 963.9325247232626, 10195.694129176136, 10712.196585256137, 10889.673309800719, 10927.617533386294, 11011.889881101246, 481.1387616167092, 489.13667377079486, 492.55669897092184, 504.15805604639604, 514.6474664854512, 5797.768089276382, 6025.3974602540275, 6032.306284777219, 6054.122152287893, 9638.855417168748, 314244.0, 358280.0, 362520.0, 367736.0, 368933.0, 69535.0, 78467.0, 79544.60227698824, 79627.0, 82300.58849705714, 1046.7644779924608, 1070.9518071686794, 1080.4765280953818, 1083.3987137138806, 1093.1528065748948, 15594.347298693812, 15600.765988510408, 15666.764704416422, 15781.368745250062, 15985.68028639444, 34246.315073697886, 34353.0, 35063.47404788879, 35231.11922201965, 35416.0, 46382.53617463782, 49615.0, 49726.0, 49737.502624973284, 49991.50008500014, 8095.311898488459, 8156.347492200491, 8206.0, 8242.546659933761, 8423.326133909395, 12017.158798884344, 12325.506979721069, 12759.553415630407, 12822.294773787531, 13124.475020999053, 9970.850437243593, 10061.798764024825, 10204.846927295948, 10365.294313070955, 10527.315724477885, 6608.537402381787, 10730.785384292114, 11041.889581104086, 11131.610393636183, 11254.662360129209, 10296.794064118825, 10320.587176512856, 10414.427206503411, 10476.16190704757, 10487.161027117965, 8196.59017049157, 8292.04641466239, 8308.958455207685, 8369.163083691825, 8389.370797190113, 8068.394870384627, 9241.722748317561, 10278.588856445958, 10368.610697994798, 10384.117350025332], "unit": "score", "name": "jquery.html", "value": 8235.11218821507}, {"lowerIsBetter": false, "replicates": [1485.9182744949037, 1609.1954022988505, 1626.5933516620844, 1819.8544116470675, 1865.8134186581335, 7386.704531818727, 8009.839803203932, 8053.959730201341, 8089.433739638228, 8167.673293068277, 7887.447878648482, 8123.2282933121405, 8132.390070744703, 8142.91857081429, 8152.144024877377, 2435.5981263091567, 2457.2382561405934, 2461.2985299189736, 2462.310553045141, 2463.2979600813774, 2404.1367939846673, 2514.270861450186, 2514.572522671141, 2518.28228954747, 2537.3529749913746, 2420.1408499982517, 2437.013009731053, 2480.702315722116, 2481.268025932345, 2482.118847809029, 2458.7787099160983, 2470.4318006858434, 2481.801455883525, 2486.490269494749, 2495.201535508638, 2319.452816371676, 2322.976770232293, 2331.3355693627236, 2335.381124002141, 2475.987620061906, 8404.789880252982, 8471.279941205004, 8474.872876906851, 8481.194286542768, 8483.15168483153, 4983.875403114915, 5134.460881607415, 5146.228065790124, 5147.510986456281, 5150.61370397218, 3144.5754823099046, 3145.276586385144, 3169.556262123305, 3183.188286986827, 3215.3730022645595, 1007.450939238117, 1018.4093225929017, 1028.0439191551854, 1040.3185913226848, 1059.1632610237903, 11085.667429977113, 11116.888831111586, 11149.21955463118, 11155.219134660578, 11161.49773260197, 4494.865154045384, 4505.954940450619, 4589.2657174851865, 4650.883727906762, 4656.8602941911795, 9616.423014619146, 9653.806923861483, 9688.176504997013, 9692.079252471003, 9720.31957762964, 4939.53074457926, 4969.527894849984, 4971.37857767779, 4979.800807967641, 4990.3762029746285, 4114.629683328515, 4494.393256910275, 4643.141018911512, 4663.580277775017, 4668.11305851887, 3968.583298753647, 4010.0977280111742, 4021.1756589899, 4032.1330913853662, 4073.7759423231414, 1252.1235135405252, 1260.7730608490376, 1260.7982722764498, 1276.3554405025588, 1289.071868254855, 1496.865282124614, 1503.691743192643, 1505.6762795998693, 1515.3105337071606, 1541.6608346163825, 8067.233612806774, 8120.187981201951, 8136.7152149674475, 8143.714969976022, 8148.388870834711, 537.8601563593415, 538.3943064052941, 543.9646422982494, 548.6899901555608, 553.0818840724378, 6220.34686357935, 6227.750889964442, 6235.189425374672, 6266.68666566679, 6308.211473565804, 9926.15627671656, 9991.850122248172, 10107.69676909694, 10309.84535231972, 10314.948425257975, 9967.850482242773, 10033.548490317953, 10148.086672199537, 10178.440185789705, 10181.898181018243, 8075.798105047304, 8080.71717489885, 8137.471064380915, 8148.388870834711, 8150.98112735908, 7671.69313227487, 7745.0, 7797.181295963842, 7830.373570114263, 7862.371010319046, 8604.698835540727, 8694.695685651224, 9027.322950778587, 9261.490618016074, 9344.112309330603, 8952.910470895467, 9040.457572545669, 9085.682001129928, 9390.95304523473, 9490.810183796424, 6577.3422657733845, 6771.0182023607285, 7076.540024898365, 7152.642367881689, 7221.53060051095, 7863.488873223451, 7872.803179920548, 7891.210878912063, 7891.605419729105, 7942.563159026309, 7041.788746337618, 7180.246074162346, 7260.600666963156, 7318.743843965436, 7379.557226566423, 7076.186238582423, 7094.964525177341, 7156.248593897774, 7159.785206443815, 7174.784756457315, 7337.926620733724, 7476.327130558276, 7476.775696729107, 7486.064241969754, 7687.961560192163, 6942.201646810681, 7043.471739619651, 7046.647667616496, 7051.753188638579, 7073.0, 6639.634820084942, 6778.186617605722, 6903.585784852925, 6956.826079348057, 6958.304169583002], "unit": "score", "name": "mootools.html", "value": 4713.7015628230365}, {"lowerIsBetter": false, "replicates": [357.9409397449421, 360.2974200309394, 365.50656613571675, 366.8312576214941, 369.5528410623146, 5996.970015149924, 5997.220361353024, 6004.609700369473, 6007.128966299884, 6057.485113765324, 5699.2306038684765, 5826.563007774424, 5840.941590584093, 5980.312264089631, 5987.850303742409, 4676.275177347517, 4678.0, 4682.742449165295, 4685.531446855304, 4694.976525117387, 4499.662525310615, 4697.765111744399, 4706.858794236161, 4707.38803955487, 4714.434267887858, 4540.523245059271, 4625.236835922069, 4627.745473998929, 4644.6516511261625, 4650.023495066041, 4651.511591282901, 4665.300204969265, 4679.74261415622, 4685.0, 4693.20215563355, 4154.833806647731, 4156.937645935313, 4161.4382058422025, 4166.749995000279, 4187.392828039948, 5679.290088738908, 5684.37471878093, 5688.687122208277, 5688.857778555569, 5698.145278208261, 5453.0, 5457.781688732446, 5457.836264912019, 5460.453954604547, 5469.316335458067, 6225.87548249037, 6349.111124442582, 6372.490200783926, 6374.298827129012, 6376.330485299023, 4578.175928332898, 4589.1968905441745, 4594.793234304464, 4604.815807367701, 4611.953880461219, 6613.0, 6616.636085015322, 6621.470282377446, 6622.73509059637, 6624.205095388585, 4699.882502937386, 4715.056988602293, 4715.504871988461, 4716.434027916672, 4720.622350212044, 4773.594244489257, 4777.95222047782, 4778.0, 4781.330613714083, 4782.234842425195, 5295.417504074549, 5428.6199966002005, 5431.755570999315, 5437.0, 5440.6735595864375, 6377.5216858735785, 6407.903881441782, 6412.935870641327, 6417.614943103429, 6426.036094585849, 1609.4527860527478, 1663.5757881740321, 1676.3043337015247, 1684.115839184438, 1696.9745453818202, 1160.3096157786104, 1165.347405452949, 1171.7715045566033, 1182.3556161891618, 1186.6795965089377, 6014.398560144038, 6020.909686354708, 6040.335563088057, 6071.605345652607, 6086.147939288503, 6517.250516190604, 6522.347765223534, 6526.967365163238, 6529.902051469232, 6539.019147127969, 6098.603590766675, 6102.084687296941, 6105.32841387447, 6106.877862442726, 6110.083487476914, 3492.318997795456, 3521.735869809723, 3522.577290725078, 3527.664871837171, 3533.734969877218, 6544.181977252843, 6698.363655452724, 6707.429868461236, 6721.428678562377, 6725.495587830932, 6624.86750264992, 6640.236372817091, 6651.16860392451, 6652.866942661217, 6664.8000559983275, 6677.499187560952, 6679.532432729759, 6687.331266873371, 6687.531872768956, 6692.5984440932725, 6486.578372405778, 6490.448311893542, 6498.220213574401, 6504.15445992018, 6507.414332710079, 6260.780872669435, 6394.648294343856, 6412.262589802046, 6418.101465794886, 6426.678666066771, 6673.099131617169, 6686.331366863469, 6700.195976482853, 6704.329567043256, 6762.932370676427, 4687.835925742719, 4692.460367057832, 4697.577218050392, 4698.718076915396, 4698.765061746831, 6290.150829637941, 6456.289808121009, 6473.287938326875, 6481.740730370921, 6495.74017039332, 6445.581037232565, 6449.193850768654, 6450.129232553545, 6455.193100862392, 6463.838404039937, 6442.0, 6442.903356449563, 6444.581102228528, 6450.838729031811, 6461.19235095613, 6328.936710633019, 6330.3669633036325, 6331.525135614939, 6333.524985626004, 6337.271213810471, 6262.780802671885, 6463.15978922737, 6465.030245463218, 6474.223093228843, 6485.319041500575, 6282.623042617458, 6315.115883776183, 6332.398422149889, 6337.397947195193, 6344.492440604648], "unit": "score", "name": "prototype.html", "value": 4860.098438678691}, {"lowerIsBetter": false, "replicates": [799.3964556759646, 843.8143608406149, 881.2993670032324, 887.6715615222367, 898.1691934960161, 14575.34410951507, 14941.0, 15290.46483373082, 15390.230488475587, 15427.69144617107, 13949.860501394984, 13969.860301396982, 13988.790168147487, 14035.228062456561, 14048.71902561948, 768.2317682317682, 773.9883901741479, 904.145582424609, 918.6233644205877, 919.9632014719404, 916.1662886773038, 923.422860712055, 924.8474001789697, 925.5233554719291, 927.5686805635378, 804.5494523067072, 954.3033585482602, 963.8698775665266, 964.0552258786394, 964.1419136968069, 941.1529623338981, 952.2049089010684, 953.3850666320254, 954.0697819625879, 954.8376775948071, 695.051255036871, 701.491418721428, 702.5819637315789, 705.1819888928869, 705.5378726933867, 14477.276136193253, 14624.707505849823, 14648.047876887968, 14656.193909334983, 14772.852271477255, 13731.519396821162, 13860.237686927216, 13879.653008674763, 13967.79048314276, 14412.783808242884, 11232.719182020433, 11365.261258018203, 11955.05796647728, 12180.451879665436, 12278.754424911453, 3999.260136874658, 4023.7786921719294, 4040.7575545467366, 4056.553779084298, 4158.064435502018, 48953.510464895255, 49217.0, 50622.746886265704, 51109.48890511085, 51276.0, 10717.624883129052, 10725.14198864089, 10858.94570527158, 10872.45637718111, 11014.229003969805, 18722.157502912403, 18748.906255468635, 18754.812451875307, 18786.812131878505, 19033.857968521657, 7845.803854903673, 7882.566458844819, 7900.407469439815, 7968.920310796933, 7981.960090199512, 4635.351050852883, 4672.95327046732, 4685.718856868599, 4699.624030077585, 4722.386089808371, 3204.951925721116, 3350.0619826448633, 3365.74756893234, 3366.8316584170693, 3395.168183794986, 624.7657128576784, 654.9770758023446, 665.6804733727838, 672.9528932974742, 673.952823302374, 595.833166713321, 647.5726020826232, 659.0016125569765, 712.6045045000075, 727.385359371341, 9236.261099112055, 9831.9016809831, 10011.59529449076, 10018.849717254247, 10184.388936663823, 750.557171268954, 766.3486036868728, 766.371575308253, 779.3842864137268, 795.7095660084143, 4269.466316710411, 4494.5730155635165, 4497.078098989765, 4504.729716217037, 4552.499225085238, 56371.436285637436, 57197.0, 57407.13889291664, 57826.4217357821, 58297.0, 51817.48182518202, 52197.7390113047, 52334.73832630813, 52561.73719131456, 52798.20802687963, 45479.772601136785, 46408.303875441896, 46524.5347546527, 46776.0, 47134.29298560524, 8620.267277281502, 8663.523506207219, 8760.386772925835, 8991.325650576102, 9615.855762163714, 35557.28885422329, 35879.46180807342, 36321.27357452783, 38258.42612360761, 38413.423798642485, 42774.78612606917, 43512.0, 43536.346954795066, 44460.55539444564, 45297.77351113223, 12224.083193760682, 12277.938610306892, 12412.069094817743, 12504.124711270124, 12606.87393126057, 13095.476180952655, 13285.335733213107, 13453.730925381242, 13490.258035808125, 13925.373358199107, 11305.491252893475, 11630.53477860876, 12186.6953326164, 12331.938340308241, 12831.909287710649, 11547.364894930859, 11835.881641183822, 12523.0, 12801.231926084465, 13338.0, 11225.71935701614, 11534.0, 11670.649880503599, 11769.764604708029, 12112.0, 10421.843672345072, 10523.4738263085, 10569.260151789302, 10726.356418614909, 10859.309224783428, 9108.453492790453, 9237.399569027992, 9362.625494980397, 9380.390274632127, 9434.575444105169], "unit": "score", "name": "yui.html", "value": 6807.991902177873}], "name": "dromaeo_css", "value": 7167.437178016}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 107.0, 112.0, 112.0, 113.0, 100.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 149.0, 168.0, 124.0, 150.0, 150.0, 127.0, 174.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 160.0, 161.0, 161.0, 159.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [83.0, 73.0, 74.0, 154.0, 75.0, 74.0, 74.0, 76.0, 155.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 139.0, 95.0, 95.0, 95.0, 144.0, 96.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 62.0, 54.0, 54.0, 55.0, 53.0, 54.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 80.0, 81.0, 81.0, 78.0, 79.0, 78.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [115.0, 118.0, 117.0, 113.0, 110.0, 116.0, 118.0, 119.0, 127.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 157.0, 140.0, 134.0, 132.0, 150.0, 146.0, 142.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 71.0, 67.0, 66.0, 68.0, 66.0, 70.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1500.2}]} 12:37:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,181,35]]", "result": "1500.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,181,35]]", "result": "7167.44"}}} 12:37:30 INFO - Return code: 0 12:37:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:37:30 INFO - # TBPL SUCCESS # 12:37:30 INFO - Running post-action listener: _resource_record_post_action 12:37:30 INFO - Running post-run listener: _resource_record_post_run 12:37:31 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 457605120; Read time: 0; Write time: 408836 12:37:31 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 236294144; Read time: 0; Write time: 276620 12:37:31 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 221310976; Read time: 0; Write time: 132216 12:37:31 INFO - Running post-run listener: _upload_blobber_files 12:37:31 INFO - Blob upload gear active. 12:37:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:37:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:37:31 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', 'Date-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:37:31 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 Date-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:37:31 INFO - (blobuploader) - INFO - Open directory for files ... 12:37:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:37:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:32 INFO - (blobuploader) - INFO - Done attempting. 12:37:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:37:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:37:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:37:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:37:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:37:33 INFO - (blobuploader) - INFO - Done attempting. 12:37:33 INFO - (blobuploader) - INFO - Iteration through files over. 12:37:33 INFO - Return code: 0 12:37:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:37:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:37:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/62c0d99be24c066ab094df0af1f5101e8beafc2c8f94b5f69d6045874985c51fbf5657b9fc0959695f529769a487fdb22247fe6d07c1b14abe10fa382bf5b6a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/61ed523b73e6ce7b7fc92f2e98cd241146b3b634e2c3227191358df084172aa46fde6ff584b7bca28e3a1e6e19c5729e0345ce554aa3ffa390b332b65aba25bc"} 12:37:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:37:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:37:33 INFO - Contents: 12:37:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/62c0d99be24c066ab094df0af1f5101e8beafc2c8f94b5f69d6045874985c51fbf5657b9fc0959695f529769a487fdb22247fe6d07c1b14abe10fa382bf5b6a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/61ed523b73e6ce7b7fc92f2e98cd241146b3b634e2c3227191358df084172aa46fde6ff584b7bca28e3a1e6e19c5729e0345ce554aa3ffa390b332b65aba25bc"} 12:37:33 INFO - Running post-run listener: copy_logs_to_upload_dir 12:37:33 INFO - Copying logs to upload dir... 12:37:33 INFO - mkdir: /builds/slave/test/build/upload/logs 12:37:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.270882 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-03-02 12:37:32.834389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 12:37:32.837603) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/62c0d99be24c066ab094df0af1f5101e8beafc2c8f94b5f69d6045874985c51fbf5657b9fc0959695f529769a487fdb22247fe6d07c1b14abe10fa382bf5b6a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/61ed523b73e6ce7b7fc92f2e98cd241146b3b634e2c3227191358df084172aa46fde6ff584b7bca28e3a1e6e19c5729e0345ce554aa3ffa390b332b65aba25bc"} build_url:https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/FmVUi46VQIysl2zPni_B6A/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/62c0d99be24c066ab094df0af1f5101e8beafc2c8f94b5f69d6045874985c51fbf5657b9fc0959695f529769a487fdb22247fe6d07c1b14abe10fa382bf5b6a9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date-Non-PGO/sha512/61ed523b73e6ce7b7fc92f2e98cd241146b3b634e2c3227191358df084172aa46fde6ff584b7bca28e3a1e6e19c5729e0345ce554aa3ffa390b332b65aba25bc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 12:37:32.861856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:37:32.862149) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456947926.480646-483187769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 12:37:32.946056) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 12:37:32.946386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 12:37:32.946678) ========= ========= Total master_lag: 0.37 =========