builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1479788162.07 results: success (0) buildid: 20161121185750 builduid: 0f09016b289d43789f52069fa037d49c revision: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.068913) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.069562) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.070041) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.135293) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.135543) ========= 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=3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 20:16:02-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-11-21 20:16:02 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114813 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.264374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.264669) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015522 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.313883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:02.314205) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 998a69cbaf54e31bb5d1d95d49cde70cfe89153c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 998a69cbaf54e31bb5d1d95d49cde70cfe89153c --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=3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 20:16:02,523 truncating revision to first 12 chars 2016-11-21 20:16:02,524 Setting DEBUG logging. 2016-11-21 20:16:02,524 attempt 1/10 2016-11-21 20:16:02,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/998a69cbaf54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 20:16:03,053 unpacking tar archive at: graphics-998a69cbaf54/testing/mozharness/ program finished with exit code 0 elapsedTime=0.852365 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:03.182733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:03.183232) ========= script_repo_revision: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:03.183854) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:03.184322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 20:16:03.194775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-21 20:16:03.195078) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:16:03 INFO - MultiFileLogger online at 20161121 20:16:03 in /builds/slave/test 20:16:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 20:16:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:16:03 INFO - {'append_to_log': False, 20:16:03 INFO - 'base_work_dir': '/builds/slave/test', 20:16:03 INFO - 'blob_upload_branch': 'Graphics', 20:16:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:16:03 INFO - 'branch': 'Graphics', 20:16:03 INFO - 'buildbot_json_path': 'buildprops.json', 20:16:03 INFO - 'config_files': ('talos/linux_config.py',), 20:16:03 INFO - 'default_actions': ('clobber', 20:16:03 INFO - 'read-buildbot-config', 20:16:03 INFO - 'download-and-extract', 20:16:03 INFO - 'populate-webroot', 20:16:03 INFO - 'create-virtualenv', 20:16:03 INFO - 'install', 20:16:03 INFO - 'run-tests'), 20:16:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:16:03 INFO - 'download_minidump_stackwalk': True, 20:16:03 INFO - 'download_symbols': 'ondemand', 20:16:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:16:03 INFO - 'tooltool.py': '/tools/tooltool.py', 20:16:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:16:03 INFO - '/tools/misc-python/virtualenv.py')}, 20:16:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:16:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:16:03 INFO - 'installer_path': 'installer.exe', 20:16:03 INFO - 'log_level': 'info', 20:16:03 INFO - 'log_name': 'talos', 20:16:03 INFO - 'log_to_console': True, 20:16:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:16:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:16:03 INFO - 'opt_config_files': (), 20:16:03 INFO - 'pip_index': False, 20:16:03 INFO - 'sps_profile': False, 20:16:03 INFO - 'sps_profile_interval': 0, 20:16:03 INFO - 'suite': 'dromaeojs', 20:16:03 INFO - 'system_bits': '32', 20:16:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:16:03 INFO - 'title': 'talos-linux64-ix-030', 20:16:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:16:03 INFO - 'use_talos_json': True, 20:16:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:16:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:16:03 INFO - 'work_dir': 'build'} 20:16:03 INFO - [mozharness: 2016-11-22 04:16:03.504224Z] Running clobber step. 20:16:03 INFO - Running pre-action listener: _resource_record_pre_action 20:16:03 INFO - Running main action method: clobber 20:16:03 INFO - rmtree: /builds/slave/test/build 20:16:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:16:04 INFO - Running post-action listener: _resource_record_post_action 20:16:04 INFO - [mozharness: 2016-11-22 04:16:04.494619Z] Finished clobber step (success) 20:16:04 INFO - [mozharness: 2016-11-22 04:16:04.494720Z] Running read-buildbot-config step. 20:16:04 INFO - Running pre-action listener: _resource_record_pre_action 20:16:04 INFO - Running main action method: read_buildbot_config 20:16:04 INFO - Using buildbot properties: 20:16:04 INFO - { 20:16:04 INFO - "project": "", 20:16:04 INFO - "product": "firefox", 20:16:04 INFO - "script_repo_revision": "default", 20:16:04 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 20:16:04 INFO - "repository": "", 20:16:04 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 20:16:04 INFO - "buildid": "20161121185750", 20:16:04 INFO - "pgo_build": "False", 20:16:04 INFO - "basedir": "/builds/slave/test", 20:16:04 INFO - "buildnumber": 7, 20:16:04 INFO - "slavename": "talos-linux64-ix-030", 20:16:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:16:04 INFO - "platform": "ubuntu64_hw", 20:16:04 INFO - "scheduler": "tests-graphics-linux64-talos", 20:16:04 INFO - "branch": "graphics", 20:16:04 INFO - "repo_path": "projects/graphics", 20:16:04 INFO - "revision": "998a69cbaf54e31bb5d1d95d49cde70cfe89153c", 20:16:04 INFO - "stage_platform": "linux64", 20:16:04 INFO - "builduid": "0f09016b289d43789f52069fa037d49c", 20:16:04 INFO - "slavebuilddir": "test" 20:16:04 INFO - } 20:16:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:16:04 INFO - Running post-action listener: _resource_record_post_action 20:16:04 INFO - [mozharness: 2016-11-22 04:16:04.497126Z] Finished read-buildbot-config step (success) 20:16:04 INFO - [mozharness: 2016-11-22 04:16:04.497215Z] Running download-and-extract step. 20:16:04 INFO - Running pre-action listener: _resource_record_pre_action 20:16:04 INFO - Running main action method: download_and_extract 20:16:04 INFO - mkdir: /builds/slave/test/build/tests 20:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:04 INFO - trying https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:16:04 INFO - Downloading https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:16:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:16:05 INFO - Downloaded 1361 bytes. 20:16:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:16:05 INFO - Using the following test package requirements: 20:16:05 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:16:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:16:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'jsshell-linux-x86_64.zip'], 20:16:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:16:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:16:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:16:05 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:16:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:16:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:16:05 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:16:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:16:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:16:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:05 INFO - Fetch https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:16:05 INFO - Http code: 200 20:16:05 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 20:16:05 INFO - x-amz-cf-id: Bqn9P5CeTZ33Fq617-L_1LIOShpIJw83G0ucj5cVdkze4BV48TYMEQ== 20:16:05 INFO - x-amz-version-id: X4xwKrFj7C1kMI3lh5mcEnPpy4t7V.Ha 20:16:06 INFO - Expected file size: 20327684 20:16:06 INFO - Obtained file size: 20327684 20:16:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:16:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:16:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:16:10 INFO - Fetch https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:16:11 INFO - Http code: 200 20:16:11 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 20:16:11 INFO - x-amz-cf-id: 2qKA3fs1PDc0gJ25kuFmoFRWsrr-8wdaoTKlVrkOay1IkKeZGa-JGQ== 20:16:11 INFO - x-amz-version-id: X4xwKrFj7C1kMI3lh5mcEnPpy4t7V.Ha 20:16:11 INFO - Expected file size: 20327684 20:16:11 INFO - Obtained file size: 20327684 20:16:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:16:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:16:15 INFO - Fetch https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:16:16 INFO - Http code: 200 20:16:16 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 20:16:16 INFO - x-amz-cf-id: 1scbLH60Tk26f-o216bvooo0ufTNQrTm2mBb08JPXldVGPKveiYKWQ== 20:16:16 INFO - x-amz-version-id: NmXcg7WrjDiCGKGNmZcvbH_RrYGAJVOz 20:16:17 INFO - Expected file size: 14409392 20:16:17 INFO - Obtained file size: 14409392 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:17 INFO - trying https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:17 INFO - Downloading https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:16:20 INFO - Downloaded 55402285 bytes. 20:16:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:20 INFO - mkdir: /builds/slave/test/properties 20:16:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:16:20 INFO - Writing to file /builds/slave/test/properties/build_url 20:16:20 INFO - Contents: 20:16:20 INFO - build_url:https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:16:20 INFO - Running post-action listener: _resource_record_post_action 20:16:20 INFO - Running post-action listener: set_extra_try_arguments 20:16:20 INFO - [mozharness: 2016-11-22 04:16:20.936848Z] Finished download-and-extract step (success) 20:16:20 INFO - [mozharness: 2016-11-22 04:16:20.937074Z] Running populate-webroot step. 20:16:20 INFO - Running pre-action listener: _resource_record_pre_action 20:16:20 INFO - Running main action method: populate_webroot 20:16:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:16:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:16:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:16:20 INFO - '--tppagecycles', 20:16:20 INFO - '7'], 20:16:20 INFO - 'tests': ['tsvgm']}}, 20:16:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:16:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:16:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:16:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:16:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:16:20 INFO - 'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:16:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:16:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:16:20 INFO - 'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['damp', 'tps']}, 20:16:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:16:20 INFO - 'tests': ['damp', 'tps']}, 20:16:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['dromaeo_dom']}, 20:16:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:16:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['basic_compositor_video']}, 20:16:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:16:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['a11yr', 20:16:20 INFO - 'ts_paint', 20:16:20 INFO - 'tpaint', 20:16:20 INFO - 'sessionrestore', 20:16:20 INFO - 'sessionrestore_no_auto_restore', 20:16:20 INFO - 'tabpaint']}, 20:16:20 INFO - 'other-e10s': {'tests': ['a11yr', 20:16:20 INFO - 'ts_paint', 20:16:20 INFO - 'tpaint', 20:16:20 INFO - 'sessionrestore', 20:16:20 INFO - 'sessionrestore_no_auto_restore', 20:16:20 INFO - 'tabpaint']}, 20:16:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:16:20 INFO - 'ts_paint', 20:16:20 INFO - 'tpaint', 20:16:20 INFO - 'sessionrestore', 20:16:20 INFO - 'sessionrestore_no_auto_restore', 20:16:20 INFO - 'tabpaint']}, 20:16:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:16:20 INFO - 'ts_paint', 20:16:20 INFO - 'tpaint', 20:16:20 INFO - 'sessionrestore', 20:16:20 INFO - 'sessionrestore_no_auto_restore', 20:16:20 INFO - 'tabpaint']}, 20:16:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['a11yr', 20:16:20 INFO - 'ts_paint', 20:16:20 INFO - 'tpaint', 20:16:20 INFO - 'sessionrestore', 20:16:20 INFO - 'sessionrestore_no_auto_restore', 20:16:20 INFO - 'tabpaint']}, 20:16:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['a11yr', 20:16:20 INFO - 'ts_paint', 20:16:20 INFO - 'tpaint', 20:16:20 INFO - 'sessionrestore', 20:16:20 INFO - 'sessionrestore_no_auto_restore', 20:16:20 INFO - 'tabpaint']}, 20:16:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['tsvgx', 20:16:20 INFO - 'tsvgr_opacity', 20:16:20 INFO - 'tart', 20:16:20 INFO - 'tscrollx', 20:16:20 INFO - 'cart']}, 20:16:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:16:20 INFO - 'tsvgr_opacity', 20:16:20 INFO - 'tart', 20:16:20 INFO - 'tscrollx', 20:16:20 INFO - 'cart']}, 20:16:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:16:20 INFO - 'talos_options': ['--disable-e10s'], 20:16:20 INFO - 'tests': ['tp5o']}, 20:16:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:16:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:16:20 INFO - 'talos_options': ['--disable-e10s', 20:16:20 INFO - '--xperf_path', 20:16:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:20 INFO - 'tests': ['tp5n']}, 20:16:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:16:20 INFO - 'talos_options': ['--xperf_path', 20:16:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:16:20 INFO - 'tests': ['tp5n']}}, 20:16:20 INFO - 'talos.zip': {'path': '', 20:16:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:16:20 INFO - Running post-action listener: _resource_record_post_action 20:16:20 INFO - [mozharness: 2016-11-22 04:16:20.955958Z] Finished populate-webroot step (success) 20:16:20 INFO - [mozharness: 2016-11-22 04:16:20.956046Z] Running create-virtualenv step. 20:16:20 INFO - Running pre-action listener: _resource_record_pre_action 20:16:20 INFO - Running main action method: create_virtualenv 20:16:20 INFO - Creating virtualenv /builds/slave/test/build/venv 20:16: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 20:16:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:16:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:16:21 INFO - Using real prefix '/usr' 20:16:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:16:21 INFO - Installing distribute.............................................................................................................................................................................................done. 20:16:23 INFO - Installing pip.................done. 20:16:23 INFO - Return code: 0 20:16:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:16:23 INFO - Reading from file tmpfile_stdout 20:16:23 INFO - Output received: 20:16:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:16:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16: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 20:16: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 20:16:23 INFO - Using env: {'DISPLAY': ':0', 20:16:23 INFO - 'HOME': '/home/cltbld', 20:16:23 INFO - 'LANG': 'en_US.UTF-8', 20:16:23 INFO - 'LANGUAGE': 'en_US:en', 20:16:23 INFO - 'LOGNAME': 'cltbld', 20:16:23 INFO - 'MAIL': '/var/mail/cltbld', 20:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:23 INFO - 'MOZ_NO_REMOTE': '1', 20:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:23 INFO - 'NO_EM_RESTART': '1', 20:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:23 INFO - 'PWD': '/builds/slave/test', 20:16:23 INFO - 'SHELL': '/bin/bash', 20:16:23 INFO - 'SHLVL': '1', 20:16:23 INFO - 'TERM': 'linux', 20:16:23 INFO - 'TMOUT': '86400', 20:16:23 INFO - 'USER': 'cltbld', 20:16:23 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:23 INFO - '_': '/tools/buildbot/bin/python'} 20:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16: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 20:16:23 INFO - Cleaning up... 20:16:23 INFO - Return code: 0 20:16:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16: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>=3.1.1'] in /builds/slave/test/build 20:16: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>=3.1.1 20:16:23 INFO - Using env: {'DISPLAY': ':0', 20:16:23 INFO - 'HOME': '/home/cltbld', 20:16:23 INFO - 'LANG': 'en_US.UTF-8', 20:16:23 INFO - 'LANGUAGE': 'en_US:en', 20:16:23 INFO - 'LOGNAME': 'cltbld', 20:16:23 INFO - 'MAIL': '/var/mail/cltbld', 20:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:23 INFO - 'MOZ_NO_REMOTE': '1', 20:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:23 INFO - 'NO_EM_RESTART': '1', 20:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:23 INFO - 'PWD': '/builds/slave/test', 20:16:23 INFO - 'SHELL': '/bin/bash', 20:16:23 INFO - 'SHLVL': '1', 20:16:23 INFO - 'TERM': 'linux', 20:16:23 INFO - 'TMOUT': '86400', 20:16:23 INFO - 'USER': 'cltbld', 20:16:23 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:24 INFO - '_': '/tools/buildbot/bin/python'} 20:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:24 INFO - Downloading/unpacking psutil>=3.1.1 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:16:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:26 INFO - Installing collected packages: psutil 20:16:26 INFO - Running setup.py install for psutil 20:16:26 INFO - building 'psutil._psutil_linux' extension 20:16:26 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 20:16: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:16:26 INFO - building 'psutil._psutil_posix' extension 20:16:26 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 20:16: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 20:16:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:16:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:16:26 INFO - Successfully installed psutil 20:16:26 INFO - Cleaning up... 20:16:26 INFO - Return code: 0 20:16:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16: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.3'] in /builds/slave/test/build 20:16: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.3 20:16:26 INFO - Using env: {'DISPLAY': ':0', 20:16:26 INFO - 'HOME': '/home/cltbld', 20:16:26 INFO - 'LANG': 'en_US.UTF-8', 20:16:26 INFO - 'LANGUAGE': 'en_US:en', 20:16:26 INFO - 'LOGNAME': 'cltbld', 20:16:26 INFO - 'MAIL': '/var/mail/cltbld', 20:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:26 INFO - 'MOZ_NO_REMOTE': '1', 20:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:26 INFO - 'NO_EM_RESTART': '1', 20:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:26 INFO - 'PWD': '/builds/slave/test', 20:16:26 INFO - 'SHELL': '/bin/bash', 20:16:26 INFO - 'SHLVL': '1', 20:16:26 INFO - 'TERM': 'linux', 20:16:26 INFO - 'TMOUT': '86400', 20:16:26 INFO - 'USER': 'cltbld', 20:16:26 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:26 INFO - '_': '/tools/buildbot/bin/python'} 20:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:16:27 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 20:16:27 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 20:16:27 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 20:16:27 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 20:16:27 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 20:16:27 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 20:16:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:16:29 INFO - Installing collected packages: mozsystemmonitor 20:16:29 INFO - Running setup.py install for mozsystemmonitor 20:16:29 INFO - Successfully installed mozsystemmonitor 20:16:29 INFO - Cleaning up... 20:16:29 INFO - Return code: 0 20:16:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:16:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:16:29 INFO - Using env: {'DISPLAY': ':0', 20:16:29 INFO - 'HOME': '/home/cltbld', 20:16:29 INFO - 'LANG': 'en_US.UTF-8', 20:16:29 INFO - 'LANGUAGE': 'en_US:en', 20:16:29 INFO - 'LOGNAME': 'cltbld', 20:16:29 INFO - 'MAIL': '/var/mail/cltbld', 20:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:29 INFO - 'MOZ_NO_REMOTE': '1', 20:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:29 INFO - 'NO_EM_RESTART': '1', 20:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:29 INFO - 'PWD': '/builds/slave/test', 20:16:29 INFO - 'SHELL': '/bin/bash', 20:16:29 INFO - 'SHLVL': '1', 20:16:29 INFO - 'TERM': 'linux', 20:16:29 INFO - 'TMOUT': '86400', 20:16:29 INFO - 'USER': 'cltbld', 20:16:29 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:29 INFO - '_': '/tools/buildbot/bin/python'} 20:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:29 INFO - Downloading/unpacking jsonschema==2.5.1 20:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:16:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:31 INFO - Downloading functools32-3.2.3-2.tar.gz 20:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:16:31 INFO - warning: no files found matching '*.txt' 20:16:31 INFO - no previously-included directories found matching 'build' 20:16:31 INFO - no previously-included directories found matching 'dist' 20:16:31 INFO - no previously-included directories found matching '.git*' 20:16:31 INFO - Installing collected packages: jsonschema, functools32 20:16:31 INFO - Running setup.py install for functools32 20:16:31 INFO - warning: no files found matching '*.txt' 20:16:31 INFO - no previously-included directories found matching 'build' 20:16:31 INFO - no previously-included directories found matching 'dist' 20:16:31 INFO - no previously-included directories found matching '.git*' 20:16:31 INFO - Successfully installed jsonschema functools32 20:16:31 INFO - Cleaning up... 20:16:31 INFO - Return code: 0 20:16:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:16:31 INFO - Using env: {'DISPLAY': ':0', 20:16:31 INFO - 'HOME': '/home/cltbld', 20:16:31 INFO - 'LANG': 'en_US.UTF-8', 20:16:31 INFO - 'LANGUAGE': 'en_US:en', 20:16:31 INFO - 'LOGNAME': 'cltbld', 20:16:31 INFO - 'MAIL': '/var/mail/cltbld', 20:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:31 INFO - 'MOZ_NO_REMOTE': '1', 20:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:31 INFO - 'NO_EM_RESTART': '1', 20:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:31 INFO - 'PWD': '/builds/slave/test', 20:16:31 INFO - 'SHELL': '/bin/bash', 20:16:31 INFO - 'SHLVL': '1', 20:16:31 INFO - 'TERM': 'linux', 20:16:31 INFO - 'TMOUT': '86400', 20:16:31 INFO - 'USER': 'cltbld', 20:16:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:31 INFO - '_': '/tools/buildbot/bin/python'} 20:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:16:32 INFO - Cleaning up... 20:16:32 INFO - Return code: 0 20:16:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:32 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 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16:32 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 20:16:32 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 20:16:32 INFO - Using env: {'DISPLAY': ':0', 20:16:32 INFO - 'HOME': '/home/cltbld', 20:16:32 INFO - 'LANG': 'en_US.UTF-8', 20:16:32 INFO - 'LANGUAGE': 'en_US:en', 20:16:32 INFO - 'LOGNAME': 'cltbld', 20:16:32 INFO - 'MAIL': '/var/mail/cltbld', 20:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:32 INFO - 'MOZ_NO_REMOTE': '1', 20:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:32 INFO - 'NO_EM_RESTART': '1', 20:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:32 INFO - 'PWD': '/builds/slave/test', 20:16:32 INFO - 'SHELL': '/bin/bash', 20:16:32 INFO - 'SHLVL': '1', 20:16:32 INFO - 'TERM': 'linux', 20:16:32 INFO - 'TMOUT': '86400', 20:16:32 INFO - 'USER': 'cltbld', 20:16:32 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:32 INFO - '_': '/tools/buildbot/bin/python'} 20:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:32 INFO - Downloading/unpacking blobuploader==1.2.4 20:16:32 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 20:16:32 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 20:16:32 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 20:16:32 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 20:16:32 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 20:16:32 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 20:16:34 INFO - Downloading blobuploader-1.2.4.tar.gz 20:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:16:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:16:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:16:34 INFO - Downloading docopt-0.6.1.tar.gz 20:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:16:34 INFO - Installing collected packages: blobuploader, requests, docopt 20:16:34 INFO - Running setup.py install for blobuploader 20:16:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:16:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:16:35 INFO - Running setup.py install for requests 20:16:35 INFO - Running setup.py install for docopt 20:16:35 INFO - Successfully installed blobuploader requests docopt 20:16:35 INFO - Cleaning up... 20:16:35 INFO - Return code: 0 20:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:35 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 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16:35 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 20:16:35 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 20:16:35 INFO - Using env: {'DISPLAY': ':0', 20:16:35 INFO - 'HOME': '/home/cltbld', 20:16:35 INFO - 'LANG': 'en_US.UTF-8', 20:16:35 INFO - 'LANGUAGE': 'en_US:en', 20:16:35 INFO - 'LOGNAME': 'cltbld', 20:16:35 INFO - 'MAIL': '/var/mail/cltbld', 20:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:35 INFO - 'MOZ_NO_REMOTE': '1', 20:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:35 INFO - 'NO_EM_RESTART': '1', 20:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:35 INFO - 'PWD': '/builds/slave/test', 20:16:35 INFO - 'SHELL': '/bin/bash', 20:16:35 INFO - 'SHLVL': '1', 20:16:35 INFO - 'TERM': 'linux', 20:16:35 INFO - 'TMOUT': '86400', 20:16:35 INFO - 'USER': 'cltbld', 20:16:35 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:35 INFO - '_': '/tools/buildbot/bin/python'} 20:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:35 INFO - Running setup.py (path:/tmp/pip-VJOpue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:35 INFO - Running setup.py (path:/tmp/pip-nwKe81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:35 INFO - Running setup.py (path:/tmp/pip-ym4kql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:36 INFO - Running setup.py (path:/tmp/pip-Rwsfgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:36 INFO - Running setup.py (path:/tmp/pip-2OeSZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:36 INFO - Running setup.py (path:/tmp/pip-B1vNdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:36 INFO - Running setup.py (path:/tmp/pip-1pF206-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:36 INFO - Running setup.py (path:/tmp/pip-STP6Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:36 INFO - Running setup.py (path:/tmp/pip-DnvcdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:36 INFO - Running setup.py (path:/tmp/pip-OOCCz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:36 INFO - Running setup.py (path:/tmp/pip-CtK0k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:36 INFO - Running setup.py (path:/tmp/pip-h7syQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:36 INFO - Running setup.py (path:/tmp/pip-kv2FlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:36 INFO - Running setup.py (path:/tmp/pip-x1BK3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:36 INFO - Running setup.py (path:/tmp/pip-DqvKMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:36 INFO - Running setup.py (path:/tmp/pip-wjQNUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:36 INFO - Running setup.py (path:/tmp/pip-fGt1t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:16:37 INFO - Running setup.py install for manifestparser 20:16:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Running setup.py install for mozcrash 20:16:37 INFO - Running setup.py install for mozdebug 20:16:37 INFO - Running setup.py install for mozdevice 20:16:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Running setup.py install for mozfile 20:16:37 INFO - Running setup.py install for mozhttpd 20:16:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Running setup.py install for mozinfo 20:16:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Running setup.py install for mozInstall 20:16:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:16:37 INFO - Running setup.py install for mozleak 20:16:37 INFO - Running setup.py install for mozlog 20:16:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:16:38 INFO - Running setup.py install for moznetwork 20:16:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:16:38 INFO - Running setup.py install for mozprocess 20:16:38 INFO - Running setup.py install for mozprofile 20:16:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:16:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:16:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:16:38 INFO - Running setup.py install for mozrunner 20:16:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:16:38 INFO - Running setup.py install for mozscreenshot 20:16:38 INFO - Running setup.py install for moztest 20:16:38 INFO - Running setup.py install for mozversion 20:16:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:16:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:16:38 INFO - Cleaning up... 20:16:38 INFO - Return code: 0 20:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:38 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 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16:38 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 20:16:38 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 20:16:38 INFO - Using env: {'DISPLAY': ':0', 20:16:38 INFO - 'HOME': '/home/cltbld', 20:16:38 INFO - 'LANG': 'en_US.UTF-8', 20:16:38 INFO - 'LANGUAGE': 'en_US:en', 20:16:38 INFO - 'LOGNAME': 'cltbld', 20:16:38 INFO - 'MAIL': '/var/mail/cltbld', 20:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:38 INFO - 'MOZ_NO_REMOTE': '1', 20:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:38 INFO - 'NO_EM_RESTART': '1', 20:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:38 INFO - 'PWD': '/builds/slave/test', 20:16:38 INFO - 'SHELL': '/bin/bash', 20:16:38 INFO - 'SHLVL': '1', 20:16:38 INFO - 'TERM': 'linux', 20:16:38 INFO - 'TMOUT': '86400', 20:16:38 INFO - 'USER': 'cltbld', 20:16:38 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:38 INFO - '_': '/tools/buildbot/bin/python'} 20:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:16:39 INFO - Running setup.py (path:/tmp/pip-6Dhlhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:16:39 INFO - Running setup.py (path:/tmp/pip-eN94sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:16:39 INFO - Running setup.py (path:/tmp/pip-NBHMBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:16:39 INFO - Running setup.py (path:/tmp/pip-TmxjUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:16:39 INFO - Running setup.py (path:/tmp/pip-Xqsl5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:16:39 INFO - Running setup.py (path:/tmp/pip-4jDVJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:16:39 INFO - Running setup.py (path:/tmp/pip-iV1bHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:16:39 INFO - Running setup.py (path:/tmp/pip-J1gLEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:16:39 INFO - Running setup.py (path:/tmp/pip-393Ndw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:16:39 INFO - Running setup.py (path:/tmp/pip-kiHmQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:16:39 INFO - Running setup.py (path:/tmp/pip-LNgJYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:16:39 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)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:16:39 INFO - Running setup.py (path:/tmp/pip-bsRhgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:16:39 INFO - Running setup.py (path:/tmp/pip-Div_uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:16:40 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)) 20:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:16:40 INFO - Running setup.py (path:/tmp/pip-OM5OHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 20:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:40 INFO - Running setup.py (path:/tmp/pip-Nu3Tiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:16:40 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)) 20:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:16:40 INFO - Running setup.py (path:/tmp/pip-1q01VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:16:40 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)) 20:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:16:40 INFO - Running setup.py (path:/tmp/pip-5J6CZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:16:40 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)) 20:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:16:40 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)) 20:16:40 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:40 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:16:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:16:40 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 20:16:40 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 20:16:40 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 20:16:40 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 20:16:40 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 20:16:40 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 20:16:42 INFO - Downloading blessings-1.6.tar.gz 20:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:16:42 INFO - Installing collected packages: blessings 20:16:42 INFO - Running setup.py install for blessings 20:16:42 INFO - Successfully installed blessings 20:16:42 INFO - Cleaning up... 20:16:42 INFO - Return code: 0 20:16:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:16:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:42 INFO - Reading from file tmpfile_stdout 20:16:42 INFO - Current package versions: 20:16:42 INFO - argparse == 1.2.1 20:16:42 INFO - blessings == 1.6 20:16:42 INFO - blobuploader == 1.2.4 20:16:42 INFO - docopt == 0.6.1 20:16:42 INFO - functools32 == 3.2.3-2 20:16:42 INFO - jsonschema == 2.5.1 20:16:42 INFO - manifestparser == 1.1 20:16:42 INFO - mozInstall == 1.12 20:16:42 INFO - mozcrash == 1.0 20:16:42 INFO - mozdebug == 0.1 20:16:42 INFO - mozdevice == 0.49 20:16:42 INFO - mozfile == 1.2 20:16:42 INFO - mozhttpd == 0.7 20:16:42 INFO - mozinfo == 0.9 20:16:42 INFO - mozleak == 0.1 20:16:42 INFO - mozlog == 3.4 20:16:42 INFO - moznetwork == 0.27 20:16:42 INFO - mozprocess == 0.23 20:16:42 INFO - mozprofile == 0.28 20:16:42 INFO - mozrunner == 6.13 20:16:42 INFO - mozscreenshot == 0.1 20:16:42 INFO - mozsystemmonitor == 0.3 20:16:42 INFO - moztest == 0.7 20:16:42 INFO - mozversion == 1.4 20:16:42 INFO - psutil == 3.1.1 20:16:42 INFO - requests == 1.2.3 20:16:42 INFO - wsgiref == 0.1.2 20:16:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:42 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 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16:42 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 20:16:42 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 20:16:42 INFO - Using env: {'DISPLAY': ':0', 20:16:42 INFO - 'HOME': '/home/cltbld', 20:16:42 INFO - 'LANG': 'en_US.UTF-8', 20:16:42 INFO - 'LANGUAGE': 'en_US:en', 20:16:42 INFO - 'LOGNAME': 'cltbld', 20:16:42 INFO - 'MAIL': '/var/mail/cltbld', 20:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:42 INFO - 'MOZ_NO_REMOTE': '1', 20:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:42 INFO - 'NO_EM_RESTART': '1', 20:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:42 INFO - 'PWD': '/builds/slave/test', 20:16:42 INFO - 'SHELL': '/bin/bash', 20:16:42 INFO - 'SHLVL': '1', 20:16:42 INFO - 'TERM': 'linux', 20:16:42 INFO - 'TMOUT': '86400', 20:16:42 INFO - 'USER': 'cltbld', 20:16:42 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:42 INFO - '_': '/tools/buildbot/bin/python'} 20:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 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)) 20:16:42 INFO - Cleaning up... 20:16:42 INFO - Return code: 0 20:16:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:16:42 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 0x7fd2406b4e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc6db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe09130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, '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': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', '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 20:16:42 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 20:16:42 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 20:16:42 INFO - Using env: {'DISPLAY': ':0', 20:16:42 INFO - 'HOME': '/home/cltbld', 20:16:42 INFO - 'LANG': 'en_US.UTF-8', 20:16:42 INFO - 'LANGUAGE': 'en_US:en', 20:16:42 INFO - 'LOGNAME': 'cltbld', 20:16:42 INFO - 'MAIL': '/var/mail/cltbld', 20:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:42 INFO - 'MOZ_NO_REMOTE': '1', 20:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:42 INFO - 'NO_EM_RESTART': '1', 20:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:42 INFO - 'PWD': '/builds/slave/test', 20:16:42 INFO - 'SHELL': '/bin/bash', 20:16:42 INFO - 'SHLVL': '1', 20:16:42 INFO - 'TERM': 'linux', 20:16:42 INFO - 'TMOUT': '86400', 20:16:42 INFO - 'USER': 'cltbld', 20:16:42 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:42 INFO - '_': '/tools/buildbot/bin/python'} 20:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:16:43 INFO - Cleaning up... 20:16:43 INFO - Return code: 0 20:16:43 INFO - Running post-action listener: _resource_record_post_action 20:16:43 INFO - Running post-action listener: _start_resource_monitoring 20:16:43 INFO - Starting resource monitoring. 20:16:43 INFO - [mozharness: 2016-11-22 04:16:43.198027Z] Finished create-virtualenv step (success) 20:16:43 INFO - [mozharness: 2016-11-22 04:16:43.198490Z] Running install step. 20:16:43 INFO - Running pre-action listener: _resource_record_pre_action 20:16:43 INFO - Running main action method: install 20:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:16:43 INFO - Reading from file tmpfile_stdout 20:16:43 INFO - Detecting whether we're running mozinstall >=1.0... 20:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:16:43 INFO - Reading from file tmpfile_stdout 20:16:43 INFO - Output received: 20:16:43 INFO - Usage: mozinstall [options] installer 20:16:43 INFO - Options: 20:16:43 INFO - -h, --help show this help message and exit 20:16:43 INFO - -d DEST, --destination=DEST 20:16:43 INFO - Directory to install application into. [default: 20:16:43 INFO - "/builds/slave/test"] 20:16:43 INFO - --app=APP Application being installed. [default: firefox] 20:16:43 INFO - mkdir: /builds/slave/test/build/application 20:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:16:59 INFO - Reading from file tmpfile_stdout 20:16:59 INFO - Output received: 20:16:59 INFO - /builds/slave/test/build/application/firefox/firefox 20:16:59 INFO - Running post-action listener: _resource_record_post_action 20:16:59 INFO - [mozharness: 2016-11-22 04:16:59.466132Z] Finished install step (success) 20:16:59 INFO - [mozharness: 2016-11-22 04:16:59.466369Z] Running run-tests step. 20:16:59 INFO - Running pre-action listener: _resource_record_pre_action 20:16:59 INFO - Running main action method: run_tests 20:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:16:59 INFO - Python 2.7.3 20:16:59 INFO - Return code: 0 20:16:59 INFO - grabbing minidump binary from tooltool 20:16:59 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:16:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe97fc0>, '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 0xe98ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe99350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:16:59 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 20:16:59 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 20:16:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:16:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:16:59 INFO - Return code: 0 20:16:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:16:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:16:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:16:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:16:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 20:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 20:16:59 INFO - Using env: {'DISPLAY': ':0', 20:16:59 INFO - 'HOME': '/home/cltbld', 20:16:59 INFO - 'LANG': 'en_US.UTF-8', 20:16:59 INFO - 'LANGUAGE': 'en_US:en', 20:16:59 INFO - 'LOGNAME': 'cltbld', 20:16:59 INFO - 'MAIL': '/var/mail/cltbld', 20:16:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:16:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:16:59 INFO - 'MOZ_NO_REMOTE': '1', 20:16:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:16:59 INFO - 'NO_EM_RESTART': '1', 20:16:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:16:59 INFO - 'PWD': '/builds/slave/test', 20:16:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:16:59 INFO - 'SHELL': '/bin/bash', 20:16:59 INFO - 'SHLVL': '1', 20:16:59 INFO - 'TERM': 'linux', 20:16:59 INFO - 'TMOUT': '86400', 20:16:59 INFO - 'USER': 'cltbld', 20:16:59 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202', 20:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:16:59 INFO - '_': '/tools/buildbot/bin/python'} 20:16:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 20:16:59 INFO - mozversion application_buildid: 20161121185750 20:16:59 INFO - mozversion application_changeset: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c 20:16:59 INFO - mozversion application_display_name: Nightly 20:16:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:16:59 INFO - mozversion application_name: Firefox 20:16:59 INFO - mozversion application_remotingname: firefox 20:16:59 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 20:16:59 INFO - mozversion application_vendor: Mozilla 20:16:59 INFO - mozversion application_version: 53.0a1 20:16:59 INFO - mozversion platform_buildid: 20161121185750 20:16:59 INFO - mozversion platform_changeset: 998a69cbaf54e31bb5d1d95d49cde70cfe89153c 20:16:59 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 20:16:59 INFO - mozversion platform_version: 53.0a1 20:16:59 INFO - using testdate: 1479788219 20:16:59 INFO - actual date: 1479788219 20:16:59 INFO - starting webserver on 'localhost:40373' 20:16:59 INFO - SUITE-START | Running 2 tests 20:16:59 INFO - TEST-START | dromaeo_css 20:16:59 INFO - operating with platform_type : linux_ 20:16:59 INFO - Initialising browser for dromaeo_css test... 20:16:59 INFO - TEST-INFO | started process 26813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKt3jap/profile http://localhost:40373/getInfo.html) 20:17:04 INFO - PROCESS | 26813 | __metrics Screen width/height:1600/1200 20:17:04 INFO - PROCESS | 26813 | colorDepth:24 20:17:04 INFO - PROCESS | 26813 | Browser inner width/height: 1024/697 20:17:04 INFO - PROCESS | 26813 | __metrics 20:17:04 INFO - PROCESS | 26813 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:17:04 INFO - PROCESS | 26813 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:06 INFO - TEST-INFO | 26813: exit 0 20:17:06 INFO - Browser initialized. 20:17:06 INFO - Running cycle 1/1 for dromaeo_css test... 20:17:06 INFO - TEST-INFO | started process 26900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKt3jap/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:18 INFO - PROCESS | 26900 | RSS: Main: 174985216 20:17:18 INFO - PROCESS | 26900 | 20:18:10 INFO - PROCESS | 26900 | 1479788290373 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] 20:20:24 INFO - PROCESS | 26900 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40373/tests/dromaeo/cssquery-ext.html) 20:20:26 INFO - PROCESS | 26900 | RSS: Main: 300466176 20:20:26 INFO - PROCESS | 26900 | 20:23:29 INFO - PROCESS | 26900 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-ext.html (next: http://localhost:40373/tests/dromaeo/cssquery-jquery.html) 20:23:29 INFO - PROCESS | 26900 | RSS: Main: 291012608 20:23:29 INFO - PROCESS | 26900 | 20:26:31 INFO - PROCESS | 26900 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40373/tests/dromaeo/cssquery-mootools.html) 20:26:32 INFO - PROCESS | 26900 | RSS: Main: 223842304 20:26:32 INFO - PROCESS | 26900 | 20:29:34 INFO - PROCESS | 26900 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40373/tests/dromaeo/cssquery-prototype.html) 20:29:35 INFO - PROCESS | 26900 | RSS: Main: 221061120 20:29:35 INFO - PROCESS | 26900 | 20:32:38 INFO - PROCESS | 26900 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40373/tests/dromaeo/cssquery-yui.html) 20:32:39 INFO - PROCESS | 26900 | RSS: Main: 220192768 20:32:39 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | Cycle 1(1): loaded http://localhost:40373/tests/dromaeo/cssquery-yui.html (next: http://localhost:40373/tests/dromaeo/cssquery-dojo.html) 20:35:42 INFO - PROCESS | 26900 | RSS: Main: 296730624 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | __start_tp_report 20:35:42 INFO - PROCESS | 26900 | _x_x_mozilla_page_load 20:35:42 INFO - PROCESS | 26900 | _x_x_mozilla_page_load_details 20:35:42 INFO - PROCESS | 26900 | |i|pagename|runs| 20:35:42 INFO - PROCESS | 26900 | |0;dojo.html;2572.254046326565;2607.6088586712003;2620.659314289143;2637.301115204471;2652.2573679369784;4586.885327866805;4641.16459037374;4693.8357157499495;4726.503717109706;4730.0776348612035;4677.4854765975715;4700.85897423077;4706.8352607658735;4757.0723708876785;4803.423589169296;4271.765052922088;4296.5273819879785;4336.609705126538;4365.345198220277;4383.736975781448;4373.825046998117;4401.66987475939;4441.156180325744;4449.377087207778;4486.528914463983;4229.936550951738;4327.567243275679;4351.825926962918;4369.169857727022;4457.420535330402;4267.935980960288;4332.913341733148;4343.261645520269;4344.978275108636;4351.173277077345;4308.310670292738;4314.784260786948;4321.351797230409;4322.7190232634775;4322.762248076355;4681.695689780154;4698.506656801055;4698.953010469886;4701.788419521095;4712.740799256074;4932.260160975847;4966.255061740731;4977.552020318189;5017.297578339036;5020.548150666421;5049.596032317406;5066.620003499752;5067.265246539268;5072.112380333427;5084.186530155194;4720.740359280238;4721.598664113589;4725.952740472551;4728.976355118202;4772.308015337757;5064.4935506449065;5147.7683504242395;5164.586833053347;5170.095233334151;5218.165093585084;4791.041791641685;4852.102361063215;4854.393200849894;4920.6801557898625;4927.975360123248;4999.0501804657;5008.248762685626;5010.298558201855;5012.448630650625;5014.348134742533;4951.603871690256;4952.182889823211;4955.876103097379;4957.355543779286;4967.279744437036;4935.062338155739;4947.480514545993;5019.52314530119;5020.49795020495;5109.897802044013;4328.891777705519;4332.4367832181615;4340.804663790074;4397.098594788061;4439.067795762861;3829.942550861739;3831.2529056834205;3846.6345697158727;3853.9229215416094;3896.629820167136;4238.894027649333;4300.978495107504;4301.741895486281;4312.784360781949;4379.956200437955;5004.124278251292;5085.1355269604255;5085.542301192911;5087.821926232564;5135.845924622267;4345.587169218919;4349.673774466928;4373.803178856959;4412.6690498212765;4419.845305414295;4435.090806384684;4495.483019452805;4498.5501449854755;4526.818927243005;4585.816567337336;4676.298555216608;4685.086408150514;4692.624590032721;4707.741074240949;4735.17134501454;5010.649254552146;5013.323201367914;5015.749212539431;5029.547340739351;5067.366579177603;4532.32015197723;4580.541945805393;4585.6102231310715;4675.579197872208;4708.717476951394;4891.217405215149;4927.457979622311;4948.727819969936;5008.073506401327;5014.674046186986;5033.245013248042;5038.647294689483;5045.470225626256;5046.116929537389;5093.92359114621;4910.091633047898;4916;4917.655764096479;4919.950800492093;4968.180250258667;4779.139754844162;4787.234042553175;4801.303810947324;4823.493533178966;4850.80596776125;4710.128626204163;4768;4772.188727916332;4806.110869489155;4814.518548145157;4880.585150262267;4882.6826256293225;4886.584640305614;4886.975565122151;4928.260760885896;4717.1744944633865;4769.73766442849;4773.284007398918;4776.47458779527;4815.975920120377 20:35:42 INFO - PROCESS | 26900 | |1;ext.html;557.434204282653;561.4441702714313;576.2278546747358;579.333766168906;585.3210276079749;28315.575266370994;31485;38857.22285554291;40346.59653403465;40477;39754.60245397545;40111.197776044464;40234.39648405269;40277.59722402775;40289;7420.517666351683;7507.361874240696;7580.090389153282;7585.089789225273;7589.127250366223;7493.925060749404;7583.203763604824;7583.27958843909;7588.317051465367;7590.506617069873;7602.961985190094;7633.274838890296;7645.847083058336;7649.388048956098;7652.273034061755;7584.203658615848;7616.809579760495;7621.771346859603;7622.237776222389;7629.580373079479;7445.739399121059;7520.398368130536;7526.36025937796;7527.736529221505;7528.924710752877;37301.25397492035;37509.62490375089;37637;37653.43519847204;37659.43510847339;2953.114065780279;2978.181000224934;3015.351699384621;3201.3437245364876;3227.9031629051165;27927.720722792714;28315.71684283172;28394;28401.431971360456;29442.705572944426;3282.5896762904636;3374.780639258465;3375.476801095834;3474.513568100468;3508.5088087667746;251968;253317;253331;254890;255580;30642.38715225683;31642.525362119588;52964.73517632387;52985.735071324394;53460;32882;32921.67078329234;33129.50305745416;33160.834195828866;33167.66832331646;11062.889371106186;11079.390633515073;11167.050800682033;11211.775764484664;11235.269707468988;8774.210321071134;8996.100389961082;9005.549722513848;9016.819663606691;9040.367174297737;7641.121271053788;7683.1548529661695;7709.537427754352;7724.575148366781;7739.806504837424;3050.23744063984;3106.08370530694;3109.0828205679377;3118.1269244611544;3143.2770462793687;884.2351366068305;896.5069211933411;899.6221586933503;973.8393165127816;993.6720882108887;26828;26884.193474195807;27080.337574501158;27516.58725119125;27626.309342266202;901.6258252825004;927.7866090799154;959.6353385713384;995.8257304971601;996.820572296979;14484.420623175165;14512;14684;14755.262236888113;15048.623784405478;387477;391095;392579;392652;393279;47123.52876471191;47777.522224777305;47811;47846;47850;989.5448093876897;990.1138481059412;1049.3074570783247;1165.7493638867684;1179.9115066370057;26765.86617066902;28408.306920100255;29260.707392925797;30373.481325934055;31501.8424907874;44659.33011004903;45127;45307.773461132485;45366;45371.54628453673;327437;333202;333247;333456;333837;24169.63745543783;24453.144139955017;24983.75016249814;26604.669766511983;26699.733002669724;40262;40618;40656.59343406646;41063.589364105974;41879.581204188784;34216.486752699224;34294.14264643404;34651.826740866134;34676.826615867765;35278.47082293819;34894.65105349015;34974.300513990085;35172;35188;35193.64806351904;33875;34221.82889085539;34529;34922;35329.646703532635;27876.44247115087;31521;31868.521972169972;31917.202069947507;31943.930653175823;24480.26559203227;24704.50590988206;24919.626205606568;25291.620625690262;25406.491870162863 20:35:42 INFO - PROCESS | 26900 | |2;jquery.html;325.45648766559844;343.65291056033396;350.15263063386607;352.75131032622005;369.99445008324864;12690.936545317272;13769.586912392631;15940.362385504595;17038.23327950242;17810.821891781077;15138.848611513882;15990.440334588291;16520;16899.23953422096;17091.487255382326;4766.618670506368;5009.373828271466;5013.6490445668815;5014.84955451337;5137.357830271216;5309.088728057896;5471.534919531845;5471.5896307776875;5474.315710536183;5474.42518535554;5128.53843154116;5408.540274076689;5420.647657902244;5486.396496385394;5486.698231597261;5364.839054828361;5398.24424580559;5401.675899446046;5410.08028635133;5694.4590263924865;5306.70813105279;5314.362276526803;5318.175682769177;5318.282031925718;5318.30861987943;11884.168108232427;12107.93946030273;12114.212576182608;12152.270863748203;12255.203411778206;1830.1764206107173;1843.0139875166722;1882.491727233653;1913.579012617222;2019.9697004544796;8412.579371031425;8752.56237188138;9016.053314402025;9161.541922903894;9223.631054757801;1572.1353255709428;1624.3746157729358;1649.6948064607966;1669.290551515601;1734.3669560610285;61809.07286390708;62815.62851079765;63643;63795.36204637987;65135.67432162809;9633.229341652652;9861.309708320348;9866.977269659703;9972.152367048737;9980.401175929323;13574.321283935764;13597.824348104255;13598.864011359958;13605.863941360658;13606.387712552762;6115.388461153849;6243.937560624427;6279.466245369194;6379;6447.871042579122;5672.14917762339;5698.3162020556965;5811.186433899257;5846.1230815377185;5855.970720146372;4206.200821843901;4219.185750127474;4257.446531950888;4260.804396702473;4328.978355108205;1700.7874015748032;1728.6974779413551;1792.4712209898112;1797.299053369187;1851.1484717030316;815.3232816762073;817.7301490508119;829.7966998085508;838.4298676899645;874.4709450782312;15744.92127539355;16472.4234651789;16996.61324674422;16998.575035623962;17199.1400429978;816.1389733830865;831.4429332347341;831.7296878514506;837.9120192379834;839.345310657688;9163.496007719506;9204.079592040876;9593.808123837483;9632.711018669452;9704.70885873425;287208;291305;356709.35940890113;357661;357875;78450.60774696204;78842.6057869707;80104;80575;84831.15168848356;894.0478390514212;894.2398960883327;912.926965842731;912.9315301352425;923.0169869089533;14943.746781285883;15515.844841551892;16323.673526529165;16546.917265413595;16586.75119873179;35613;36516;36703.81648091743;36843;37617;50984.74507627438;52975.47024529705;53007.20489192588;53716.19425708696;54076;6311.96844015777;6604.9009264862025;6797.89803152963;6802.659867006729;7189.640517974185;9343.813123737624;11028.44857757125;11394.829077563678;11494.94252528732;11497.54009839597;9351.48566828831;9501.714948551555;9516.571754271214;10259.948700256451;10414.635487757892;9649.324547281904;9824.705258842247;9889.307748457539;10077.244206684381;10125.18998480105;9292.535373231447;9564.33049686543;9829.655962041294;9832.9016709832;9859.704208873745;6577.3422657735755;6666.866662666623;6673.566218195801;6805.863882722417;6811.284815094344;7202.243764404662;8664.913350866664;9589.904100958902;9756.658516951873;10110.443925584164 20:35:42 INFO - PROCESS | 26900 | |3;mootools.html;1190.2263528706335;1303.7522870654577;1356.6201463590191;1408.7323408552375;1626.5445675210945;5757;6398.232212134544;6462.192225971754;6489.415952564274;6635.071090047397;6601.405873471386;6663.267040625527;6670.76652317169;6679.398854103142;6688.464922806176;1981.1778112083505;2022.5853699991467;2027.2803154880025;2031.4108908416542;2034.6541088015074;1940.5924755801298;1968.379960312497;1972.5364539333245;2005.5186755178797;2005.9598808023904;1937.5662010112555;1979.3270288102042;1997.510609900569;1998.1707591349573;1999.070432249004;1959.5297128689083;1977.812107849752;1980.6335827871817;1980.6731889238258;1985.1463870535663;1954.9706754398696;1972.260402349119;1974.5557249618864;1975.7925417831063;1984.0674882805058;6228;6310.432061114522;6328.810135695937;6329.4619957303685;6422.807315780534;3878.4957955465893;4037.798110094513;4041.2725709372303;4045.4336392905016;4056.0873803394297;2570.678665166854;2711.810173287871;2748.230495461274;2756.1180422264883;2762.9723702762917;832.5920299053481;843.616154649639;846.6401779243797;847.9788005299855;881.9823603527958;8396.286315663176;8471.83056338876;8482.915170848337;8500.149985001512;8530.976282846099;3320.9501857472155;3382.7801192922875;3503.2993401319327;3505.789652620851;3512.5433693620175;6876.209235937931;6889.311068893071;6892.310768923167;6892.414144797748;6894.724211031503;3788.6590206881515;3863.285292220948;3873.360895452275;3874.4188371744463;3878.631530004645;3237.951430728541;3345.49817527368;3529;3580.3913334733156;3583;2880.15035564509;2883.480973424804;2976.7023297670494;2983.209449495885;3001.6848230935875;900.9009009009004;910.9316801239934;916.3677062826629;916.3906002508257;922.1608336413831;815.9551224682699;824.2328408360994;835.6949713354703;852.3607294529103;857.4897935728231;4689.20283551797;4764;4784.851635607499;4793.089313030513;4859.562639362403;392.06296950288834;408.7384074192519;411.8476163819406;413.03556196282017;413.9337705967031;3299.950500742491;3318.286568387808;3345.4480010797947;3364.7644664873224;3544.4151714967256;7691.1155217150745;7887.487313324616;7968.402369822171;7974.362051035903;7977.2022797719765;7955.4431189817315;7957.840843183104;7960.203979602109;7960.721374751856;7964.84070318602;6293.118963345135;6344.777932772423;6349.904751428732;6391.041343798374;6402.48780097591;4652.720836749806;4653.883652908705;4700.741459219639;4898.363212782316;4900.460949295646;7034.261402552658;7178.138623365229;7266.382357499671;7278.927210728037;7280.235575264521;7256.353293950067;7347.375473084848;7364.631768411665;7370.44721645868;7423.8144046399275;5802.564807639359;5864.824055278348;5908.05471124618;5921.703914804329;5928.911066334094;5577.581681373995;5791.305043394819;6084.665343406155;6300.558960872695;6309.810705678837;5703.315602127771;5741.655500669973;5742.626729262584;5751.827445176651;5772;5498.340199176125;5572.108462645957;5580.469855363734;5625.493705566519;5741.13882917549;5206.219067139959;5534.142207957773;5588.3573389060775;5590.077637189818;5610.635308704921;4192.580741925783;4223.95776042248;4271.530131685574;4296.882810469238;4317.0934103838545;4022.416749571354;4101.159262351271;4144.647704945113;4147.79261036953;4208.305629571087 20:35:42 INFO - PROCESS | 26900 | |4;prototype.html;286.08452950558217;292.5202667625095;296.86492645846135;300.8255211977052;301.1792864444388;4783.258594917789;4783.42598888133;4822.614190864731;4826.927596086061;4829.348038014867;4724.771559394557;4727.5036121207295;4738.384010078685;4738.834140805073;4754.500777418373;3526.5239192708977;3595.3887839067293;3659.9935017870166;3660;3695.926081478369;3688.5758137814228;3689.35436298648;3696.075981004749;3698.4637227601984;3715.294094122108;3664;3665.3952097903816;3681.7975011374365;3697.6672099511175;3700.2599480103954;3530.223350862806;3599.100224943777;3611.115276757211;3659.524261845943;3697.300970291675;3249.918752031218;3251.398491279121;3254.0400581828417;3258.2506023614465;3260.983695081533;4597.862064138081;4601.608863246628;4614.169449499089;4622.151139544209;4647.256438969783;3920.6863450923856;4124.463819703449;4161.146964872194;4183.477065366829;4197.887559796656;4920.311156438066;4929.359183306147;4930;4938.9012219755405;4940.308356830046;3442.1050526862946;3445.174057749397;3457.429524128541;3462.774919630241;3465.6361082086523;5096.9490305097215;5163.406208286057;5213.530782229617;5228.816991405282;5242.501962313612;3463.6363181866045;3480.129967508123;3481.1819222482695;3494.336076145524;3496.125968507873;3528.5236493073107;3529.6823285904393;3535.2399234164777;3540.0795793093466;3556.8043757593064;4096.3855421686985;4107.322291821875;4108.322126849096;4108.650764685035;4112.485939257593;4847.854564363075;4907.484714105039;4978.929530151035;4993.603070526167;4994.350734404504;1194.8685644579089;1216.403962058585;1221.1818081885158;1227.300438749904;1230.3356187658565;752.4732687119039;776.4060493722307;810.7689308547153;815.2458975447687;821.5850995247481;4092.5498195198506;4277.508086570022;4403.229434848889;4415.845445409395;4423.20382331177;5109.284700141983;5110.725727051501;5131.589472842164;5134.072434587543;5135.768890399941;4399.812050746281;4405.915858898784;4408.118376324748;4412.382266482695;4418.64650827933;2487.676602041759;2597.6363309136736;2603.388203772112;2619.2404202781363;2623.9868800655872;4598.563136502027;4602.493725690171;4612.74801265114;4632.884177895579;4635.513271106485;5054.69671819692;5055.977608956447;5063.49365063498;5074.82238121664;5078.187490001582;4465.59809617136;4779.832705855348;4807.18277892759;4811.206150985048;4818.325434439182;5119.6416250862085;5132.204508301219;5139.6145289102715;5142.228665700175;5144.459831717616;4892.192788190051;5033.496650334937;5047.87380315495;5049.545540901337;5053.166227572409;4739.028499157595;4740.739259340631;4785.377900872864;4813.638977076664;4815.759212039454;3533.1520435094876;3537.8148320311952;3563.287342531556;3568.3220188164164;3579.552555930509;5102.872428189325;5142.897142057063;5162;5177.91263834599;5188.688678679291;4829.27560865873;4982.601391888713;4986.626003049713;5000.249962505508;5005.399352077774;4954.5788607968725;4974.278729584118;5000.699958002531;5008.474110218374;5030.320906677552;4923.803047878188;4924.7537623119415;4926.088673595396;4926.733702496748;4933.851984440473;4755.714657120584;4783.617310615073;4868.805247790048;4910.091633047898;4991.425986011655;4902.142125128017;4912.312276281252;4924.310596516419;4929.359183306147;4935.654504184673 20:35:42 INFO - PROCESS | 26900 | |5;yui.html;622.0265284829239;627.4603840697;635.1425575473112;641.3330136657876;650.158045331296;12076.456559454835;12436.689082772935;12643.431045602947;12967.351632418366;13139.080264381497;11742.471588778504;11812.114091443133;11819.231749936249;11841.171118021743;11848.407579621027;753.3069575990089;755.9017327747385;773.3928865840317;779.6101949025488;782.3311069035949;631.8673078653488;650.74946145734;744.341257986683;788.3771820261986;790.3519114326255;825.938054645904;826.3348004856089;826.36782861111;826.5949684654506;827.1810907201886;823.3701218567801;823.4565186976627;824.3281725393784;825.2036784502983;825.4098319701412;481.33335330567064;486.5718168012162;579.1110645159702;591.6923199936009;603.0140719922914;12402.007839372829;12464.626061218178;12485.563005294862;12493.812592811115;12501.437435315433;11093.223474356799;11101.222914395996;11283;11337.603183888607;11905.404729763477;10934.179936504714;10943.179261555335;11189.272697274733;11195.328280303207;11401.89531768571;4061.375449820066;4074.5314288856866;4175.039740859589;4240.385144154111;4290.785460726951;50782.98434031336;51091.23363149593;52145.7392713034;53134.73432632851;53135.734321328535;9255.352125351295;9490.905090949002;9514.666986655433;9577.856332155023;9605.135537801492;16931.32274708998;17270.82729172692;17281.56796080108;17282.395116170872;17294.567635808955;6246.937530624727;6326.715297811609;6338.556301058881;6582.275949645536;6600.405963463311;3396;3486.6687664671817;3526.5944416392445;3557.625606976493;3570.4822800694274;2756.807023508375;2839.1908306132655;2841.659000919903;2851.244420228641;2853.372258103214;487.9243717223836;491.9139150648694;497.45528646132425;507.47729838266645;515.5875299760177;562.4066609726696;582.5048708597658;594.4917095883044;598.7844376024627;599.2210126835097;7182.640867956581;7226.205117437078;7609.847803044019;7626.389888808882;7661.61691915402;549.5740800879271;579.1284117403366;590.1148277583625;590.9172715819789;597.8535258861607;3615.891523254307;3633.0554055945645;3837.9424308635394;3852.2680690668685;3929.58739332366;66643;70497;71756.64121679358;71884.64057679783;72282.2771772286;60415;60957.390426095175;61256.38743612596;61444;62443;36089.63910360863;40768.38847417291;54862.45137548653;58928.41071589229;59734.70132649309;7275.527090739085;7275.781726548212;7389.371903388273;7440.925590744023;7613.853177100449;38728.61271387363;39459.2108157841;39543.40684889672;40173.59826401698;40178.39732403958;51224;54232;54526;55555;56354.71822640861;8374.413791034569;8403.957980210304;8417.70538031166;8485.745427637181;8633.611487483204;9927.751806204613;10589.9470502647;10590.205734570092;10611.734706632087;11180.944095279798;8955.686550970684;9072.274218062672;9212.769680757767;9340.252779777737;9548.092931171528;9399.154076133182;9522.47626380528;9539.761505962406;9802.705918822447;9805.607775688892;9504.667336643184;10175.185985121025;10224.59101635956;10460.320079195133;11152.888471115184;8445.915540844513;8481.921929127404;8566.742997710078;8619.8707019396;8791.45989498745;9405;9602.471864047266;9611;9800.901990979999;9832.852507212541 20:35:42 INFO - PROCESS | 26900 | __end_tp_report 20:35:42 INFO - PROCESS | 26900 | __start_cc_report 20:35:42 INFO - PROCESS | 26900 | _x_x_mozilla_cycle_collect,1261 20:35:42 INFO - PROCESS | 26900 | __end_cc_report 20:35:42 INFO - PROCESS | 26900 | __startTimestamp1479789342491__endTimestamp 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | ------- Summary: start ------- 20:35:42 INFO - PROCESS | 26900 | Number of tests: 6 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | [#0] dojo.html Cycles:165 Average:4644.70 Median:4730.08 stddev:471.40 (10.0%) stddev-sans-first:443.92 20:35:42 INFO - PROCESS | 26900 | Values: 2572.3 2607.6 2620.7 2637.3 2652.3 4586.9 4641.2 4693.8 4726.5 4730.1 4677.5 4700.9 4706.8 4757.1 4803.4 4271.8 4296.5 4336.6 4365.3 4383.7 4373.8 4401.7 4441.2 4449.4 4486.5 4229.9 4327.6 4351.8 4369.2 4457.4 4267.9 4332.9 4343.3 4345.0 4351.2 4308.3 4314.8 4321.4 4322.7 4322.8 4681.7 4698.5 4699.0 4701.8 4712.7 4932.3 4966.3 4977.6 5017.3 5020.5 5049.6 5066.6 5067.3 5072.1 5084.2 4720.7 4721.6 4726.0 4729.0 4772.3 5064.5 5147.8 5164.6 5170.1 5218.2 4791.0 4852.1 4854.4 4920.7 4928.0 4999.1 5008.2 5010.3 5012.4 5014.3 4951.6 4952.2 4955.9 4957.4 4967.3 4935.1 4947.5 5019.5 5020.5 5109.9 4328.9 4332.4 4340.8 4397.1 4439.1 3829.9 3831.3 3846.6 3853.9 3896.6 4238.9 4301.0 4301.7 4312.8 4380.0 5004.1 5085.1 5085.5 5087.8 5135.8 4345.6 4349.7 4373.8 4412.7 4419.8 4435.1 4495.5 4498.6 4526.8 4585.8 4676.3 4685.1 4692.6 4707.7 4735.2 5010.6 5013.3 5015.7 5029.5 5067.4 4532.3 4580.5 4585.6 4675.6 4708.7 4891.2 4927.5 4948.7 5008.1 5014.7 5033.2 5038.6 5045.5 5046.1 5093.9 4910.1 4916.0 4917.7 4920.0 4968.2 4779.1 4787.2 4801.3 4823.5 4850.8 4710.1 4768.0 4772.2 4806.1 4814.5 4880.6 4882.7 4886.6 4887.0 4928.3 4717.2 4769.7 4773.3 4776.5 4816.0 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | [#1] ext.html Cycles:180 Average:46285.56 Median:35304.06 stddev:87399.44 (247.6%) stddev-sans-first:87577.18 20:35:42 INFO - PROCESS | 26900 | Values: 557.4 561.4 576.2 579.3 585.3 28315.6 31485.0 38857.2 40346.6 40477.0 39754.6 40111.2 40234.4 40277.6 40289.0 7420.5 7507.4 7580.1 7585.1 7589.1 7493.9 7583.2 7583.3 7588.3 7590.5 7603.0 7633.3 7645.8 7649.4 7652.3 7584.2 7616.8 7621.8 7622.2 7629.6 7445.7 7520.4 7526.4 7527.7 7528.9 37301.3 37509.6 37637.0 37653.4 37659.4 2953.1 2978.2 3015.4 3201.3 3227.9 27927.7 28315.7 28394.0 28401.4 29442.7 3282.6 3374.8 3375.5 3474.5 3508.5 251968.0 253317.0 253331.0 254890.0 255580.0 30642.4 31642.5 52964.7 52985.7 53460.0 32882.0 32921.7 33129.5 33160.8 33167.7 11062.9 11079.4 11167.1 11211.8 11235.3 8774.2 8996.1 9005.5 9016.8 9040.4 7641.1 7683.2 7709.5 7724.6 7739.8 3050.2 3106.1 3109.1 3118.1 3143.3 884.2 896.5 899.6 973.8 993.7 26828.0 26884.2 27080.3 27516.6 27626.3 901.6 927.8 959.6 995.8 996.8 14484.4 14512.0 14684.0 14755.3 15048.6 387477.0 391095.0 392579.0 392652.0 393279.0 47123.5 47777.5 47811.0 47846.0 47850.0 989.5 990.1 1049.3 1165.7 1179.9 26765.9 28408.3 29260.7 30373.5 31501.8 44659.3 45127.0 45307.8 45366.0 45371.5 327437.0 333202.0 333247.0 333456.0 333837.0 24169.6 24453.1 24983.8 26604.7 26699.7 40262.0 40618.0 40656.6 41063.6 41879.6 34216.5 34294.1 34651.8 34676.8 35278.5 34894.7 34974.3 35172.0 35188.0 35193.6 33875.0 34221.8 34529.0 34922.0 35329.6 27876.4 31521.0 31868.5 31917.2 31943.9 24480.3 24704.5 24919.6 25291.6 25406.5 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | [#2] jquery.html Cycles:180 Average:22115.47 Median:29557.22 stddev:55342.72 (187.2%) stddev-sans-first:55473.79 20:35:42 INFO - PROCESS | 26900 | Values: 325.5 343.7 350.2 352.8 370.0 12690.9 13769.6 15940.4 17038.2 17810.8 15138.8 15990.4 16520.0 16899.2 17091.5 4766.6 5009.4 5013.6 5014.8 5137.4 5309.1 5471.5 5471.6 5474.3 5474.4 5128.5 5408.5 5420.6 5486.4 5486.7 5364.8 5398.2 5401.7 5410.1 5694.5 5306.7 5314.4 5318.2 5318.3 5318.3 11884.2 12107.9 12114.2 12152.3 12255.2 1830.2 1843.0 1882.5 1913.6 2020.0 8412.6 8752.6 9016.1 9161.5 9223.6 1572.1 1624.4 1649.7 1669.3 1734.4 61809.1 62815.6 63643.0 63795.4 65135.7 9633.2 9861.3 9867.0 9972.2 9980.4 13574.3 13597.8 13598.9 13605.9 13606.4 6115.4 6243.9 6279.5 6379.0 6447.9 5672.1 5698.3 5811.2 5846.1 5856.0 4206.2 4219.2 4257.4 4260.8 4329.0 1700.8 1728.7 1792.5 1797.3 1851.1 815.3 817.7 829.8 838.4 874.5 15744.9 16472.4 16996.6 16998.6 17199.1 816.1 831.4 831.7 837.9 839.3 9163.5 9204.1 9593.8 9632.7 9704.7 287208.0 291305.0 356709.4 357661.0 357875.0 78450.6 78842.6 80104.0 80575.0 84831.2 894.0 894.2 912.9 912.9 923.0 14943.7 15515.8 16323.7 16546.9 16586.8 35613.0 36516.0 36703.8 36843.0 37617.0 50984.7 52975.5 53007.2 53716.2 54076.0 6312.0 6604.9 6797.9 6802.7 7189.6 9343.8 11028.4 11394.8 11494.9 11497.5 9351.5 9501.7 9516.6 10259.9 10414.6 9649.3 9824.7 9889.3 10077.2 10125.2 9292.5 9564.3 9829.7 9832.9 9859.7 6577.3 6666.9 6673.6 6805.9 6811.3 7202.2 8664.9 9589.9 9756.7 10110.4 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | [#3] mootools.html Cycles:180 Average:4340.60 Median:5352.28 stddev:2307.16 (43.1%) stddev-sans-first:2301.48 20:35:42 INFO - PROCESS | 26900 | Values: 1190.2 1303.8 1356.6 1408.7 1626.5 5757.0 6398.2 6462.2 6489.4 6635.1 6601.4 6663.3 6670.8 6679.4 6688.5 1981.2 2022.6 2027.3 2031.4 2034.7 1940.6 1968.4 1972.5 2005.5 2006.0 1937.6 1979.3 1997.5 1998.2 1999.1 1959.5 1977.8 1980.6 1980.7 1985.1 1955.0 1972.3 1974.6 1975.8 1984.1 6228.0 6310.4 6328.8 6329.5 6422.8 3878.5 4037.8 4041.3 4045.4 4056.1 2570.7 2711.8 2748.2 2756.1 2763.0 832.6 843.6 846.6 848.0 882.0 8396.3 8471.8 8482.9 8500.1 8531.0 3321.0 3382.8 3503.3 3505.8 3512.5 6876.2 6889.3 6892.3 6892.4 6894.7 3788.7 3863.3 3873.4 3874.4 3878.6 3238.0 3345.5 3529.0 3580.4 3583.0 2880.2 2883.5 2976.7 2983.2 3001.7 900.9 910.9 916.4 916.4 922.2 816.0 824.2 835.7 852.4 857.5 4689.2 4764.0 4784.9 4793.1 4859.6 392.1 408.7 411.8 413.0 413.9 3300.0 3318.3 3345.4 3364.8 3544.4 7691.1 7887.5 7968.4 7974.4 7977.2 7955.4 7957.8 7960.2 7960.7 7964.8 6293.1 6344.8 6349.9 6391.0 6402.5 4652.7 4653.9 4700.7 4898.4 4900.5 7034.3 7178.1 7266.4 7278.9 7280.2 7256.4 7347.4 7364.6 7370.4 7423.8 5802.6 5864.8 5908.1 5921.7 5928.9 5577.6 5791.3 6084.7 6300.6 6309.8 5703.3 5741.7 5742.6 5751.8 5772.0 5498.3 5572.1 5580.5 5625.5 5741.1 5206.2 5534.1 5588.4 5590.1 5610.6 4192.6 4224.0 4271.5 4296.9 4317.1 4022.4 4101.2 4144.6 4147.8 4208.3 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | [#4] prototype.html Cycles:180 Average:4091.21 Median:4686.01 stddev:1211.11 (25.8%) stddev-sans-first:1180.36 20:35:42 INFO - PROCESS | 26900 | Values: 286.1 292.5 296.9 300.8 301.2 4783.3 4783.4 4822.6 4826.9 4829.3 4724.8 4727.5 4738.4 4738.8 4754.5 3526.5 3595.4 3660.0 3660.0 3695.9 3688.6 3689.4 3696.1 3698.5 3715.3 3664.0 3665.4 3681.8 3697.7 3700.3 3530.2 3599.1 3611.1 3659.5 3697.3 3249.9 3251.4 3254.0 3258.3 3261.0 4597.9 4601.6 4614.2 4622.2 4647.3 3920.7 4124.5 4161.1 4183.5 4197.9 4920.3 4929.4 4930.0 4938.9 4940.3 3442.1 3445.2 3457.4 3462.8 3465.6 5096.9 5163.4 5213.5 5228.8 5242.5 3463.6 3480.1 3481.2 3494.3 3496.1 3528.5 3529.7 3535.2 3540.1 3556.8 4096.4 4107.3 4108.3 4108.7 4112.5 4847.9 4907.5 4978.9 4993.6 4994.4 1194.9 1216.4 1221.2 1227.3 1230.3 752.5 776.4 810.8 815.2 821.6 4092.5 4277.5 4403.2 4415.8 4423.2 5109.3 5110.7 5131.6 5134.1 5135.8 4399.8 4405.9 4408.1 4412.4 4418.6 2487.7 2597.6 2603.4 2619.2 2624.0 4598.6 4602.5 4612.7 4632.9 4635.5 5054.7 5056.0 5063.5 5074.8 5078.2 4465.6 4779.8 4807.2 4811.2 4818.3 5119.6 5132.2 5139.6 5142.2 5144.5 4892.2 5033.5 5047.9 5049.5 5053.2 4739.0 4740.7 4785.4 4813.6 4815.8 3533.2 3537.8 3563.3 3568.3 3579.6 5102.9 5142.9 5162.0 5177.9 5188.7 4829.3 4982.6 4986.6 5000.2 5005.4 4954.6 4974.3 5000.7 5008.5 5030.3 4923.8 4924.8 4926.1 4926.7 4933.9 4755.7 4783.6 4868.8 4910.1 4991.4 4902.1 4912.3 4924.3 4929.4 4935.7 20:35:42 INFO - PROCESS | 26900 | 20:35:42 INFO - PROCESS | 26900 | [#5] yui.html Cycles:180 Average:14503.54 Median:591.30 stddev:19024.30 (3217.3%) stddev-sans-first:19049.11 20:35:42 INFO - PROCESS | 26900 | Values: 622.0 627.5 635.1 641.3 650.2 12076.5 12436.7 12643.4 12967.4 13139.1 11742.5 11812.1 11819.2 11841.2 11848.4 753.3 755.9 773.4 779.6 782.3 631.9 650.7 744.3 788.4 790.4 825.9 826.3 826.4 826.6 827.2 823.4 823.5 824.3 825.2 825.4 481.3 486.6 579.1 591.7 603.0 12402.0 12464.6 12485.6 12493.8 12501.4 11093.2 11101.2 11283.0 11337.6 11905.4 10934.2 10943.2 11189.3 11195.3 11401.9 4061.4 4074.5 4175.0 4240.4 4290.8 50783.0 51091.2 52145.7 53134.7 53135.7 9255.4 9490.9 9514.7 9577.9 9605.1 16931.3 17270.8 17281.6 17282.4 17294.6 6246.9 6326.7 6338.6 6582.3 6600.4 3396.0 3486.7 3526.6 3557.6 3570.5 2756.8 2839.2 2841.7 2851.2 2853.4 487.9 491.9 497.5 507.5 515.6 562.4 582.5 594.5 598.8 599.2 7182.6 7226.2 7609.8 7626.4 7661.6 549.6 579.1 590.1 590.9 597.9 3615.9 3633.1 3837.9 3852.3 3929.6 66643.0 70497.0 71756.6 71884.6 72282.3 60415.0 60957.4 61256.4 61444.0 62443.0 36089.6 40768.4 54862.5 58928.4 59734.7 7275.5 7275.8 7389.4 7440.9 7613.9 38728.6 39459.2 39543.4 40173.6 40178.4 51224.0 54232.0 54526.0 55555.0 56354.7 8374.4 8404.0 8417.7 8485.7 8633.6 9927.8 10589.9 10590.2 10611.7 11180.9 8955.7 9072.3 9212.8 9340.3 9548.1 9399.2 9522.5 9539.8 9802.7 9805.6 9504.7 10175.2 10224.6 10460.3 11152.9 8445.9 8481.9 8566.7 8619.9 8791.5 9405.0 9602.5 9611.0 9800.9 9832.9 20:35:42 INFO - PROCESS | 26900 | -------- Summary: end -------- 20:35:42 INFO - PROCESS | 26900 | 20:35:43 INFO - TEST-INFO | 26900: exit 0 20:35:43 INFO - TEST-OK | dromaeo_css | took 1123698ms 20:35:43 INFO - TEST-START | kraken 20:35:43 INFO - operating with platform_type : linux_ 20:35:43 INFO - Initialising browser for kraken test... 20:35:43 INFO - TEST-INFO | started process 27195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNv17BC/profile http://localhost:40373/getInfo.html) 20:35:47 INFO - PROCESS | 27195 | __metrics Screen width/height:1600/1200 20:35:47 INFO - PROCESS | 27195 | colorDepth:24 20:35:47 INFO - PROCESS | 27195 | Browser inner width/height: 1024/697 20:35:47 INFO - PROCESS | 27195 | __metrics 20:35:48 INFO - PROCESS | 27195 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:35:48 INFO - PROCESS | 27195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:35:49 INFO - PROCESS | 27195 | console.error: PushService: 20:35:49 INFO - PROCESS | 27195 | stateChangeProcessEnqueue: Error transitioning state 20:35:49 INFO - PROCESS | 27195 | UnknownError 20:35:49 INFO - TEST-INFO | 27195: exit 0 20:35:49 INFO - Browser initialized. 20:35:49 INFO - Running cycle 1/1 for kraken test... 20:35:49 INFO - TEST-INFO | started process 27276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNv17BC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:02 INFO - PROCESS | 27276 | RSS: Main: 175362048 20:36:02 INFO - PROCESS | 27276 | 20:36:04 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-beat-detection) 20:36:05 INFO - PROCESS | 27276 | RSS: Main: 231620608 20:36:05 INFO - PROCESS | 27276 | 20:36:08 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-dft) 20:36:09 INFO - PROCESS | 27276 | RSS: Main: 218923008 20:36:09 INFO - PROCESS | 27276 | 20:36:12 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-fft) 20:36:13 INFO - PROCESS | 27276 | RSS: Main: 300163072 20:36:13 INFO - PROCESS | 27276 | 20:36:15 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40373/tests/kraken/driver.html?testName=audio-oscillator) 20:36:16 INFO - PROCESS | 27276 | RSS: Main: 212320256 20:36:16 INFO - PROCESS | 27276 | 20:36:18 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40373/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:36:18 INFO - PROCESS | 27276 | RSS: Main: 214745088 20:36:18 INFO - PROCESS | 27276 | 20:36:22 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40373/tests/kraken/driver.html?testName=imaging-darkroom) 20:36:22 INFO - PROCESS | 27276 | RSS: Main: 254115840 20:36:22 INFO - PROCESS | 27276 | 20:36:26 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40373/tests/kraken/driver.html?testName=imaging-desaturate) 20:36:26 INFO - PROCESS | 27276 | RSS: Main: 253497344 20:36:26 INFO - PROCESS | 27276 | 20:36:29 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40373/tests/kraken/driver.html?testName=json-parse-financial) 20:36:30 INFO - PROCESS | 27276 | RSS: Main: 251985920 20:36:30 INFO - PROCESS | 27276 | 20:36:31 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40373/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:36:32 INFO - PROCESS | 27276 | RSS: Main: 214089728 20:36:32 INFO - PROCESS | 27276 | 20:36:34 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:36:35 INFO - PROCESS | 27276 | RSS: Main: 222142464 20:36:35 INFO - PROCESS | 27276 | 20:36:37 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:36:37 INFO - PROCESS | 27276 | RSS: Main: 230715392 20:36:37 INFO - PROCESS | 27276 | 20:36:40 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:36:41 INFO - PROCESS | 27276 | RSS: Main: 239419392 20:36:41 INFO - PROCESS | 27276 | 20:36:44 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:36:45 INFO - PROCESS | 27276 | RSS: Main: 235196416 20:36:45 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | Cycle 1(1): loaded http://localhost:40373/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40373/tests/kraken/driver.html?testName=ai-astar) 20:36:47 INFO - PROCESS | 27276 | RSS: Main: 287019008 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | __start_tp_report 20:36:47 INFO - PROCESS | 27276 | _x_x_mozilla_page_load 20:36:47 INFO - PROCESS | 27276 | _x_x_mozilla_page_load_details 20:36:47 INFO - PROCESS | 27276 | |i|pagename|runs| 20:36:47 INFO - PROCESS | 27276 | |0;ai-astar;108;117;116;117;118;118;116;117;116;115 20:36:47 INFO - PROCESS | 27276 | |1;audio-beat-detection;153;130;130;157;130;129;127;126;168;128 20:36:47 INFO - PROCESS | 27276 | |2;audio-dft;161;161;161;162;163;161;162;161;162;159 20:36:47 INFO - PROCESS | 27276 | |3;audio-fft;76;76;77;118;78;80;77;77;113;76 20:36:47 INFO - PROCESS | 27276 | |4;audio-oscillator;84;82;122;83;83;83;103;83;82;121 20:36:47 INFO - PROCESS | 27276 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 20:36:47 INFO - PROCESS | 27276 | |6;imaging-darkroom;146;147;147;147;147;147;147;147;146;147 20:36:47 INFO - PROCESS | 27276 | |7;imaging-desaturate;95;96;95;96;96;95;95;96;95;95 20:36:47 INFO - PROCESS | 27276 | |8;json-parse-financial;62;63;65;65;64;64;64;65;64;64 20:36:47 INFO - PROCESS | 27276 | |9;json-stringify-tinderbox;66;66;66;66;66;66;66;67;67;75 20:36:47 INFO - PROCESS | 27276 | |10;stanford-crypto-aes;85;93;85;85;84;85;85;85;92;94 20:36:47 INFO - PROCESS | 27276 | |11;stanford-crypto-ccm;146;141;142;162;144;153;140;154;185;148 20:36:47 INFO - PROCESS | 27276 | |12;stanford-crypto-pbkdf2;178;178;177;178;178;180;182;179;176;176 20:36:47 INFO - PROCESS | 27276 | |13;stanford-crypto-sha256-iterative;73;70;72;70;73;70;69;70;70;69 20:36:47 INFO - PROCESS | 27276 | __end_tp_report 20:36:47 INFO - PROCESS | 27276 | __start_cc_report 20:36:47 INFO - PROCESS | 27276 | _x_x_mozilla_cycle_collect,1948 20:36:47 INFO - PROCESS | 27276 | __end_cc_report 20:36:47 INFO - PROCESS | 27276 | __startTimestamp1479789407267__endTimestamp 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | ------- Summary: start ------- 20:36:47 INFO - PROCESS | 27276 | Number of tests: 14 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:2.90 (2.5%) stddev-sans-first:1.00 20:36:47 INFO - PROCESS | 27276 | Values: 108.0 117.0 116.0 117.0 118.0 118.0 116.0 117.0 116.0 115.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:130.00 stddev:15.36 (11.8%) stddev-sans-first:15.28 20:36:47 INFO - PROCESS | 27276 | Values: 153.0 130.0 130.0 157.0 130.0 129.0 127.0 126.0 168.0 128.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.12 20:36:47 INFO - PROCESS | 27276 | Values: 161.0 161.0 161.0 162.0 163.0 161.0 162.0 161.0 162.0 159.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#3] audio-fft Cycles:10 Average:84.80 Median:77.00 stddev:16.27 (21.1%) stddev-sans-first:16.94 20:36:47 INFO - PROCESS | 27276 | Values: 76.0 76.0 77.0 118.0 78.0 80.0 77.0 77.0 113.0 76.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.00 stddev:16.49 (19.9%) stddev-sans-first:17.19 20:36:47 INFO - PROCESS | 27276 | Values: 84.0 82.0 122.0 83.0 83.0 83.0 103.0 83.0 82.0 121.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 20:36:47 INFO - PROCESS | 27276 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 20:36:47 INFO - PROCESS | 27276 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:36:47 INFO - PROCESS | 27276 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.67 20:36:47 INFO - PROCESS | 27276 | Values: 62.0 63.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 64.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:66.00 stddev:2.81 (4.3%) stddev-sans-first:2.95 20:36:47 INFO - PROCESS | 27276 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 75.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:85.00 stddev:3.97 (4.7%) stddev-sans-first:4.13 20:36:47 INFO - PROCESS | 27276 | Values: 85.0 93.0 85.0 85.0 84.0 85.0 85.0 85.0 92.0 94.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:150.50 stddev:13.63 (9.1%) stddev-sans-first:14.31 20:36:47 INFO - PROCESS | 27276 | Values: 146.0 141.0 142.0 162.0 144.0 153.0 140.0 154.0 185.0 148.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:178.00 stddev:1.81 (1.0%) stddev-sans-first:1.92 20:36:47 INFO - PROCESS | 27276 | Values: 178.0 178.0 177.0 178.0 178.0 180.0 182.0 179.0 176.0 176.0 20:36:47 INFO - PROCESS | 27276 | 20:36:47 INFO - PROCESS | 27276 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:1.51 (2.2%) stddev-sans-first:1.32 20:36:47 INFO - PROCESS | 27276 | Values: 73.0 70.0 72.0 70.0 73.0 70.0 69.0 70.0 70.0 69.0 20:36:47 INFO - PROCESS | 27276 | -------- Summary: end -------- 20:36:47 INFO - PROCESS | 27276 | 20:36:48 INFO - TEST-INFO | 27276: exit 0 20:36:48 INFO - TEST-OK | kraken | took 65196ms 20:36:48 INFO - SUITE-END | took 1188s 20:36:48 INFO - Completed test suite (00:19:49) 20:36:48 INFO - javascript benchmark 20:36:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2572.254046326565, 2607.6088586712003, 2620.659314289143, 2637.301115204471, 2652.2573679369784, 4586.885327866805, 4641.16459037374, 4693.8357157499495, 4726.503717109706, 4730.0776348612035, 4677.4854765975715, 4700.85897423077, 4706.8352607658735, 4757.0723708876785, 4803.423589169296, 4271.765052922088, 4296.5273819879785, 4336.609705126538, 4365.345198220277, 4383.736975781448, 4373.825046998117, 4401.66987475939, 4441.156180325744, 4449.377087207778, 4486.528914463983, 4229.936550951738, 4327.567243275679, 4351.825926962918, 4369.169857727022, 4457.420535330402, 4267.935980960288, 4332.913341733148, 4343.261645520269, 4344.978275108636, 4351.173277077345, 4308.310670292738, 4314.784260786948, 4321.351797230409, 4322.7190232634775, 4322.762248076355, 4681.695689780154, 4698.506656801055, 4698.953010469886, 4701.788419521095, 4712.740799256074, 4932.260160975847, 4966.255061740731, 4977.552020318189, 5017.297578339036, 5020.548150666421, 5049.596032317406, 5066.620003499752, 5067.265246539268, 5072.112380333427, 5084.186530155194, 4720.740359280238, 4721.598664113589, 4725.952740472551, 4728.976355118202, 4772.308015337757, 5064.4935506449065, 5147.7683504242395, 5164.586833053347, 5170.095233334151, 5218.165093585084, 4791.041791641685, 4852.102361063215, 4854.393200849894, 4920.6801557898625, 4927.975360123248, 4999.0501804657, 5008.248762685626, 5010.298558201855, 5012.448630650625, 5014.348134742533, 4951.603871690256, 4952.182889823211, 4955.876103097379, 4957.355543779286, 4967.279744437036, 4935.062338155739, 4947.480514545993, 5019.52314530119, 5020.49795020495, 5109.897802044013, 4328.891777705519, 4332.4367832181615, 4340.804663790074, 4397.098594788061, 4439.067795762861, 3829.942550861739, 3831.2529056834205, 3846.6345697158727, 3853.9229215416094, 3896.629820167136, 4238.894027649333, 4300.978495107504, 4301.741895486281, 4312.784360781949, 4379.956200437955, 5004.124278251292, 5085.1355269604255, 5085.542301192911, 5087.821926232564, 5135.845924622267, 4345.587169218919, 4349.673774466928, 4373.803178856959, 4412.6690498212765, 4419.845305414295, 4435.090806384684, 4495.483019452805, 4498.5501449854755, 4526.818927243005, 4585.816567337336, 4676.298555216608, 4685.086408150514, 4692.624590032721, 4707.741074240949, 4735.17134501454, 5010.649254552146, 5013.323201367914, 5015.749212539431, 5029.547340739351, 5067.366579177603, 4532.32015197723, 4580.541945805393, 4585.6102231310715, 4675.579197872208, 4708.717476951394, 4891.217405215149, 4927.457979622311, 4948.727819969936, 5008.073506401327, 5014.674046186986, 5033.245013248042, 5038.647294689483, 5045.470225626256, 5046.116929537389, 5093.92359114621, 4910.091633047898, 4916.0, 4917.655764096479, 4919.950800492093, 4968.180250258667, 4779.139754844162, 4787.234042553175, 4801.303810947324, 4823.493533178966, 4850.80596776125, 4710.128626204163, 4768.0, 4772.188727916332, 4806.110869489155, 4814.518548145157, 4880.585150262267, 4882.6826256293225, 4886.584640305614, 4886.975565122151, 4928.260760885896, 4717.1744944633865, 4769.73766442849, 4773.284007398918, 4776.47458779527, 4815.975920120377], "value": 4615.221809520346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.434204282653, 561.4441702714313, 576.2278546747358, 579.333766168906, 585.3210276079749, 28315.575266370994, 31485.0, 38857.22285554291, 40346.59653403465, 40477.0, 39754.60245397545, 40111.197776044464, 40234.39648405269, 40277.59722402775, 40289.0, 7420.517666351683, 7507.361874240696, 7580.090389153282, 7585.089789225273, 7589.127250366223, 7493.925060749404, 7583.203763604824, 7583.27958843909, 7588.317051465367, 7590.506617069873, 7602.961985190094, 7633.274838890296, 7645.847083058336, 7649.388048956098, 7652.273034061755, 7584.203658615848, 7616.809579760495, 7621.771346859603, 7622.237776222389, 7629.580373079479, 7445.739399121059, 7520.398368130536, 7526.36025937796, 7527.736529221505, 7528.924710752877, 37301.25397492035, 37509.62490375089, 37637.0, 37653.43519847204, 37659.43510847339, 2953.114065780279, 2978.181000224934, 3015.351699384621, 3201.3437245364876, 3227.9031629051165, 27927.720722792714, 28315.71684283172, 28394.0, 28401.431971360456, 29442.705572944426, 3282.5896762904636, 3374.780639258465, 3375.476801095834, 3474.513568100468, 3508.5088087667746, 251968.0, 253317.0, 253331.0, 254890.0, 255580.0, 30642.38715225683, 31642.525362119588, 52964.73517632387, 52985.735071324394, 53460.0, 32882.0, 32921.67078329234, 33129.50305745416, 33160.834195828866, 33167.66832331646, 11062.889371106186, 11079.390633515073, 11167.050800682033, 11211.775764484664, 11235.269707468988, 8774.210321071134, 8996.100389961082, 9005.549722513848, 9016.819663606691, 9040.367174297737, 7641.121271053788, 7683.1548529661695, 7709.537427754352, 7724.575148366781, 7739.806504837424, 3050.23744063984, 3106.08370530694, 3109.0828205679377, 3118.1269244611544, 3143.2770462793687, 884.2351366068305, 896.5069211933411, 899.6221586933503, 973.8393165127816, 993.6720882108887, 26828.0, 26884.193474195807, 27080.337574501158, 27516.58725119125, 27626.309342266202, 901.6258252825004, 927.7866090799154, 959.6353385713384, 995.8257304971601, 996.820572296979, 14484.420623175165, 14512.0, 14684.0, 14755.262236888113, 15048.623784405478, 387477.0, 391095.0, 392579.0, 392652.0, 393279.0, 47123.52876471191, 47777.522224777305, 47811.0, 47846.0, 47850.0, 989.5448093876897, 990.1138481059412, 1049.3074570783247, 1165.7493638867684, 1179.9115066370057, 26765.86617066902, 28408.306920100255, 29260.707392925797, 30373.481325934055, 31501.8424907874, 44659.33011004903, 45127.0, 45307.773461132485, 45366.0, 45371.54628453673, 327437.0, 333202.0, 333247.0, 333456.0, 333837.0, 24169.63745543783, 24453.144139955017, 24983.75016249814, 26604.669766511983, 26699.733002669724, 40262.0, 40618.0, 40656.59343406646, 41063.589364105974, 41879.581204188784, 34216.486752699224, 34294.14264643404, 34651.826740866134, 34676.826615867765, 35278.47082293819, 34894.65105349015, 34974.300513990085, 35172.0, 35188.0, 35193.64806351904, 33875.0, 34221.82889085539, 34529.0, 34922.0, 35329.646703532635, 27876.44247115087, 31521.0, 31868.521972169972, 31917.202069947507, 31943.930653175823, 24480.26559203227, 24704.50590988206, 24919.626205606568, 25291.620625690262, 25406.491870162863], "value": 15987.940625843547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.45648766559844, 343.65291056033396, 350.15263063386607, 352.75131032622005, 369.99445008324864, 12690.936545317272, 13769.586912392631, 15940.362385504595, 17038.23327950242, 17810.821891781077, 15138.848611513882, 15990.440334588291, 16520.0, 16899.23953422096, 17091.487255382326, 4766.618670506368, 5009.373828271466, 5013.6490445668815, 5014.84955451337, 5137.357830271216, 5309.088728057896, 5471.534919531845, 5471.5896307776875, 5474.315710536183, 5474.42518535554, 5128.53843154116, 5408.540274076689, 5420.647657902244, 5486.396496385394, 5486.698231597261, 5364.839054828361, 5398.24424580559, 5401.675899446046, 5410.08028635133, 5694.4590263924865, 5306.70813105279, 5314.362276526803, 5318.175682769177, 5318.282031925718, 5318.30861987943, 11884.168108232427, 12107.93946030273, 12114.212576182608, 12152.270863748203, 12255.203411778206, 1830.1764206107173, 1843.0139875166722, 1882.491727233653, 1913.579012617222, 2019.9697004544796, 8412.579371031425, 8752.56237188138, 9016.053314402025, 9161.541922903894, 9223.631054757801, 1572.1353255709428, 1624.3746157729358, 1649.6948064607966, 1669.290551515601, 1734.3669560610285, 61809.07286390708, 62815.62851079765, 63643.0, 63795.36204637987, 65135.67432162809, 9633.229341652652, 9861.309708320348, 9866.977269659703, 9972.152367048737, 9980.401175929323, 13574.321283935764, 13597.824348104255, 13598.864011359958, 13605.863941360658, 13606.387712552762, 6115.388461153849, 6243.937560624427, 6279.466245369194, 6379.0, 6447.871042579122, 5672.14917762339, 5698.3162020556965, 5811.186433899257, 5846.1230815377185, 5855.970720146372, 4206.200821843901, 4219.185750127474, 4257.446531950888, 4260.804396702473, 4328.978355108205, 1700.7874015748032, 1728.6974779413551, 1792.4712209898112, 1797.299053369187, 1851.1484717030316, 815.3232816762073, 817.7301490508119, 829.7966998085508, 838.4298676899645, 874.4709450782312, 15744.92127539355, 16472.4234651789, 16996.61324674422, 16998.575035623962, 17199.1400429978, 816.1389733830865, 831.4429332347341, 831.7296878514506, 837.9120192379834, 839.345310657688, 9163.496007719506, 9204.079592040876, 9593.808123837483, 9632.711018669452, 9704.70885873425, 287208.0, 291305.0, 356709.35940890113, 357661.0, 357875.0, 78450.60774696204, 78842.6057869707, 80104.0, 80575.0, 84831.15168848356, 894.0478390514212, 894.2398960883327, 912.926965842731, 912.9315301352425, 923.0169869089533, 14943.746781285883, 15515.844841551892, 16323.673526529165, 16546.917265413595, 16586.75119873179, 35613.0, 36516.0, 36703.81648091743, 36843.0, 37617.0, 50984.74507627438, 52975.47024529705, 53007.20489192588, 53716.19425708696, 54076.0, 6311.96844015777, 6604.9009264862025, 6797.89803152963, 6802.659867006729, 7189.640517974185, 9343.813123737624, 11028.44857757125, 11394.829077563678, 11494.94252528732, 11497.54009839597, 9351.48566828831, 9501.714948551555, 9516.571754271214, 10259.948700256451, 10414.635487757892, 9649.324547281904, 9824.705258842247, 9889.307748457539, 10077.244206684381, 10125.18998480105, 9292.535373231447, 9564.33049686543, 9829.655962041294, 9832.9016709832, 9859.704208873745, 6577.3422657735755, 6666.866662666623, 6673.566218195801, 6805.863882722417, 6811.284815094344, 7202.243764404662, 8664.913350866664, 9589.904100958902, 9756.658516951873, 10110.443925584164], "value": 7747.773958834709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.2263528706335, 1303.7522870654577, 1356.6201463590191, 1408.7323408552375, 1626.5445675210945, 5757.0, 6398.232212134544, 6462.192225971754, 6489.415952564274, 6635.071090047397, 6601.405873471386, 6663.267040625527, 6670.76652317169, 6679.398854103142, 6688.464922806176, 1981.1778112083505, 2022.5853699991467, 2027.2803154880025, 2031.4108908416542, 2034.6541088015074, 1940.5924755801298, 1968.379960312497, 1972.5364539333245, 2005.5186755178797, 2005.9598808023904, 1937.5662010112555, 1979.3270288102042, 1997.510609900569, 1998.1707591349573, 1999.070432249004, 1959.5297128689083, 1977.812107849752, 1980.6335827871817, 1980.6731889238258, 1985.1463870535663, 1954.9706754398696, 1972.260402349119, 1974.5557249618864, 1975.7925417831063, 1984.0674882805058, 6228.0, 6310.432061114522, 6328.810135695937, 6329.4619957303685, 6422.807315780534, 3878.4957955465893, 4037.798110094513, 4041.2725709372303, 4045.4336392905016, 4056.0873803394297, 2570.678665166854, 2711.810173287871, 2748.230495461274, 2756.1180422264883, 2762.9723702762917, 832.5920299053481, 843.616154649639, 846.6401779243797, 847.9788005299855, 881.9823603527958, 8396.286315663176, 8471.83056338876, 8482.915170848337, 8500.149985001512, 8530.976282846099, 3320.9501857472155, 3382.7801192922875, 3503.2993401319327, 3505.789652620851, 3512.5433693620175, 6876.209235937931, 6889.311068893071, 6892.310768923167, 6892.414144797748, 6894.724211031503, 3788.6590206881515, 3863.285292220948, 3873.360895452275, 3874.4188371744463, 3878.631530004645, 3237.951430728541, 3345.49817527368, 3529.0, 3580.3913334733156, 3583.0, 2880.15035564509, 2883.480973424804, 2976.7023297670494, 2983.209449495885, 3001.6848230935875, 900.9009009009004, 910.9316801239934, 916.3677062826629, 916.3906002508257, 922.1608336413831, 815.9551224682699, 824.2328408360994, 835.6949713354703, 852.3607294529103, 857.4897935728231, 4689.20283551797, 4764.0, 4784.851635607499, 4793.089313030513, 4859.562639362403, 392.06296950288834, 408.7384074192519, 411.8476163819406, 413.03556196282017, 413.9337705967031, 3299.950500742491, 3318.286568387808, 3345.4480010797947, 3364.7644664873224, 3544.4151714967256, 7691.1155217150745, 7887.487313324616, 7968.402369822171, 7974.362051035903, 7977.2022797719765, 7955.4431189817315, 7957.840843183104, 7960.203979602109, 7960.721374751856, 7964.84070318602, 6293.118963345135, 6344.777932772423, 6349.904751428732, 6391.041343798374, 6402.48780097591, 4652.720836749806, 4653.883652908705, 4700.741459219639, 4898.363212782316, 4900.460949295646, 7034.261402552658, 7178.138623365229, 7266.382357499671, 7278.927210728037, 7280.235575264521, 7256.353293950067, 7347.375473084848, 7364.631768411665, 7370.44721645868, 7423.8144046399275, 5802.564807639359, 5864.824055278348, 5908.05471124618, 5921.703914804329, 5928.911066334094, 5577.581681373995, 5791.305043394819, 6084.665343406155, 6300.558960872695, 6309.810705678837, 5703.315602127771, 5741.655500669973, 5742.626729262584, 5751.827445176651, 5772.0, 5498.340199176125, 5572.108462645957, 5580.469855363734, 5625.493705566519, 5741.13882917549, 5206.219067139959, 5534.142207957773, 5588.3573389060775, 5590.077637189818, 5610.635308704921, 4192.580741925783, 4223.95776042248, 4271.530131685574, 4296.882810469238, 4317.0934103838545, 4022.416749571354, 4101.159262351271, 4144.647704945113, 4147.79261036953, 4208.305629571087], "value": 3518.3348478088296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.08452950558217, 292.5202667625095, 296.86492645846135, 300.8255211977052, 301.1792864444388, 4783.258594917789, 4783.42598888133, 4822.614190864731, 4826.927596086061, 4829.348038014867, 4724.771559394557, 4727.5036121207295, 4738.384010078685, 4738.834140805073, 4754.500777418373, 3526.5239192708977, 3595.3887839067293, 3659.9935017870166, 3660.0, 3695.926081478369, 3688.5758137814228, 3689.35436298648, 3696.075981004749, 3698.4637227601984, 3715.294094122108, 3664.0, 3665.3952097903816, 3681.7975011374365, 3697.6672099511175, 3700.2599480103954, 3530.223350862806, 3599.100224943777, 3611.115276757211, 3659.524261845943, 3697.300970291675, 3249.918752031218, 3251.398491279121, 3254.0400581828417, 3258.2506023614465, 3260.983695081533, 4597.862064138081, 4601.608863246628, 4614.169449499089, 4622.151139544209, 4647.256438969783, 3920.6863450923856, 4124.463819703449, 4161.146964872194, 4183.477065366829, 4197.887559796656, 4920.311156438066, 4929.359183306147, 4930.0, 4938.9012219755405, 4940.308356830046, 3442.1050526862946, 3445.174057749397, 3457.429524128541, 3462.774919630241, 3465.6361082086523, 5096.9490305097215, 5163.406208286057, 5213.530782229617, 5228.816991405282, 5242.501962313612, 3463.6363181866045, 3480.129967508123, 3481.1819222482695, 3494.336076145524, 3496.125968507873, 3528.5236493073107, 3529.6823285904393, 3535.2399234164777, 3540.0795793093466, 3556.8043757593064, 4096.3855421686985, 4107.322291821875, 4108.322126849096, 4108.650764685035, 4112.485939257593, 4847.854564363075, 4907.484714105039, 4978.929530151035, 4993.603070526167, 4994.350734404504, 1194.8685644579089, 1216.403962058585, 1221.1818081885158, 1227.300438749904, 1230.3356187658565, 752.4732687119039, 776.4060493722307, 810.7689308547153, 815.2458975447687, 821.5850995247481, 4092.5498195198506, 4277.508086570022, 4403.229434848889, 4415.845445409395, 4423.20382331177, 5109.284700141983, 5110.725727051501, 5131.589472842164, 5134.072434587543, 5135.768890399941, 4399.812050746281, 4405.915858898784, 4408.118376324748, 4412.382266482695, 4418.64650827933, 2487.676602041759, 2597.6363309136736, 2603.388203772112, 2619.2404202781363, 2623.9868800655872, 4598.563136502027, 4602.493725690171, 4612.74801265114, 4632.884177895579, 4635.513271106485, 5054.69671819692, 5055.977608956447, 5063.49365063498, 5074.82238121664, 5078.187490001582, 4465.59809617136, 4779.832705855348, 4807.18277892759, 4811.206150985048, 4818.325434439182, 5119.6416250862085, 5132.204508301219, 5139.6145289102715, 5142.228665700175, 5144.459831717616, 4892.192788190051, 5033.496650334937, 5047.87380315495, 5049.545540901337, 5053.166227572409, 4739.028499157595, 4740.739259340631, 4785.377900872864, 4813.638977076664, 4815.759212039454, 3533.1520435094876, 3537.8148320311952, 3563.287342531556, 3568.3220188164164, 3579.552555930509, 5102.872428189325, 5142.897142057063, 5162.0, 5177.91263834599, 5188.688678679291, 4829.27560865873, 4982.601391888713, 4986.626003049713, 5000.249962505508, 5005.399352077774, 4954.5788607968725, 4974.278729584118, 5000.699958002531, 5008.474110218374, 5030.320906677552, 4923.803047878188, 4924.7537623119415, 4926.088673595396, 4926.733702496748, 4933.851984440473, 4755.714657120584, 4783.617310615073, 4868.805247790048, 4910.091633047898, 4991.425986011655, 4902.142125128017, 4912.312276281252, 4924.310596516419, 4929.359183306147, 4935.654504184673], "value": 3703.4826164861897, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.0265284829239, 627.4603840697, 635.1425575473112, 641.3330136657876, 650.158045331296, 12076.456559454835, 12436.689082772935, 12643.431045602947, 12967.351632418366, 13139.080264381497, 11742.471588778504, 11812.114091443133, 11819.231749936249, 11841.171118021743, 11848.407579621027, 753.3069575990089, 755.9017327747385, 773.3928865840317, 779.6101949025488, 782.3311069035949, 631.8673078653488, 650.74946145734, 744.341257986683, 788.3771820261986, 790.3519114326255, 825.938054645904, 826.3348004856089, 826.36782861111, 826.5949684654506, 827.1810907201886, 823.3701218567801, 823.4565186976627, 824.3281725393784, 825.2036784502983, 825.4098319701412, 481.33335330567064, 486.5718168012162, 579.1110645159702, 591.6923199936009, 603.0140719922914, 12402.007839372829, 12464.626061218178, 12485.563005294862, 12493.812592811115, 12501.437435315433, 11093.223474356799, 11101.222914395996, 11283.0, 11337.603183888607, 11905.404729763477, 10934.179936504714, 10943.179261555335, 11189.272697274733, 11195.328280303207, 11401.89531768571, 4061.375449820066, 4074.5314288856866, 4175.039740859589, 4240.385144154111, 4290.785460726951, 50782.98434031336, 51091.23363149593, 52145.7392713034, 53134.73432632851, 53135.734321328535, 9255.352125351295, 9490.905090949002, 9514.666986655433, 9577.856332155023, 9605.135537801492, 16931.32274708998, 17270.82729172692, 17281.56796080108, 17282.395116170872, 17294.567635808955, 6246.937530624727, 6326.715297811609, 6338.556301058881, 6582.275949645536, 6600.405963463311, 3396.0, 3486.6687664671817, 3526.5944416392445, 3557.625606976493, 3570.4822800694274, 2756.807023508375, 2839.1908306132655, 2841.659000919903, 2851.244420228641, 2853.372258103214, 487.9243717223836, 491.9139150648694, 497.45528646132425, 507.47729838266645, 515.5875299760177, 562.4066609726696, 582.5048708597658, 594.4917095883044, 598.7844376024627, 599.2210126835097, 7182.640867956581, 7226.205117437078, 7609.847803044019, 7626.389888808882, 7661.61691915402, 549.5740800879271, 579.1284117403366, 590.1148277583625, 590.9172715819789, 597.8535258861607, 3615.891523254307, 3633.0554055945645, 3837.9424308635394, 3852.2680690668685, 3929.58739332366, 66643.0, 70497.0, 71756.64121679358, 71884.64057679783, 72282.2771772286, 60415.0, 60957.390426095175, 61256.38743612596, 61444.0, 62443.0, 36089.63910360863, 40768.38847417291, 54862.45137548653, 58928.41071589229, 59734.70132649309, 7275.527090739085, 7275.781726548212, 7389.371903388273, 7440.925590744023, 7613.853177100449, 38728.61271387363, 39459.2108157841, 39543.40684889672, 40173.59826401698, 40178.39732403958, 51224.0, 54232.0, 54526.0, 55555.0, 56354.71822640861, 8374.413791034569, 8403.957980210304, 8417.70538031166, 8485.745427637181, 8633.611487483204, 9927.751806204613, 10589.9470502647, 10590.205734570092, 10611.734706632087, 11180.944095279798, 8955.686550970684, 9072.274218062672, 9212.769680757767, 9340.252779777737, 9548.092931171528, 9399.154076133182, 9522.47626380528, 9539.761505962406, 9802.705918822447, 9805.607775688892, 9504.667336643184, 10175.185985121025, 10224.59101635956, 10460.320079195133, 11152.888471115184, 8445.915540844513, 8481.921929127404, 8566.742997710078, 8619.8707019396, 8791.45989498745, 9405.0, 9602.471864047266, 9611.0, 9800.901990979999, 9832.852507212541], "value": 5956.957490963738, "unit": "score"}], "name": "dromaeo_css", "value": 5950.194581655879, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 116.0, 117.0, 118.0, 118.0, 116.0, 117.0, 116.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 130.0, 157.0, 130.0, 129.0, 127.0, 126.0, 168.0, 128.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 163.0, 161.0, 162.0, 161.0, 162.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 118.0, 78.0, 80.0, 77.0, 77.0, 113.0, 76.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 122.0, 83.0, 83.0, 83.0, 103.0, 83.0, 82.0, 121.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 75.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 92.0, 94.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 141.0, 142.0, 162.0, 144.0, 153.0, 140.0, 154.0, 185.0, 148.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 177.0, 178.0, 178.0, 180.0, 182.0, 179.0, 176.0, 176.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 72.0, 70.0, 73.0, 70.0, 69.0, 70.0, 70.0, 69.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1570.1, "alertThreshold": 2.0}]} 20:36:48 INFO - Return code: 0 20:36:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:36:49 INFO - # TBPL SUCCESS # 20:36:49 INFO - Running post-action listener: _resource_record_post_action 20:36:49 INFO - [mozharness: 2016-11-22 04:36:49.056339Z] Finished run-tests step (success) 20:36:49 INFO - Running post-run listener: _resource_record_post_run 20:36:49 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 388485120; Read time: 0; Write time: 254056 20:36:49 INFO - TinderboxPrint: CPU usage
13.0% 20:36:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:36:49 INFO - TinderboxPrint: I/O write bytes / time
388,485,120 / 254,056 20:36:49 INFO - TinderboxPrint: CPU idle
8,359.7 (86.9%) 20:36:49 INFO - TinderboxPrint: CPU user
1,207.4 (12.6%) 20:36:49 INFO - TinderboxPrint: Swap in / out
0 / 0 20:36:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99426304; Read time: 0; Write time: 95840 20:36:49 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 289058816; Read time: 0; Write time: 158216 20:36:49 INFO - Running post-run listener: _upload_blobber_files 20:36:49 INFO - Blob upload gear active. 20:36:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:36:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:36:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:53 INFO - (blobuploader) - INFO - Done attempting. 20:36:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:36:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:54 INFO - (blobuploader) - INFO - Done attempting. 20:36:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:36:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:36:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:36:54 INFO - (blobuploader) - INFO - Done attempting. 20:36:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:36:54 INFO - Return code: 0 20:36:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:36:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:36:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2f1c5b06b756c479a90a0631341c4c40e9da9b947dc09af32f45e2efd0a18b2b6d422288eb7ac49e4f58ad696763234e9f80b8652e727c864a227dc39f8efc3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3488e728959686d11955967dca7583e9e92d4ab8a25868467f573f85922f027ae7e5d3be520c961e83e99e6002a35e62f3e8417d406e0141ba8709d217964686", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cca6adfd5f67c1b3c9a25c1273b303a2036db2dc2129d96d578cf0da3c8f7340831914bdd02d685a131fa0b806b5cf448110a5cf3f293ff6cf177d1923f4ea9"} 20:36:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:36:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:36:54 INFO - Contents: 20:36:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2f1c5b06b756c479a90a0631341c4c40e9da9b947dc09af32f45e2efd0a18b2b6d422288eb7ac49e4f58ad696763234e9f80b8652e727c864a227dc39f8efc3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3488e728959686d11955967dca7583e9e92d4ab8a25868467f573f85922f027ae7e5d3be520c961e83e99e6002a35e62f3e8417d406e0141ba8709d217964686", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cca6adfd5f67c1b3c9a25c1273b303a2036db2dc2129d96d578cf0da3c8f7340831914bdd02d685a131fa0b806b5cf448110a5cf3f293ff6cf177d1923f4ea9"} 20:36:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:36:54 INFO - Copying logs to upload dir... 20:36:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:36:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.585451 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-21 20:36:54.803453) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 20:36:54.806743) ========= 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=3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2f1c5b06b756c479a90a0631341c4c40e9da9b947dc09af32f45e2efd0a18b2b6d422288eb7ac49e4f58ad696763234e9f80b8652e727c864a227dc39f8efc3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3488e728959686d11955967dca7583e9e92d4ab8a25868467f573f85922f027ae7e5d3be520c961e83e99e6002a35e62f3e8417d406e0141ba8709d217964686", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cca6adfd5f67c1b3c9a25c1273b303a2036db2dc2129d96d578cf0da3c8f7340831914bdd02d685a131fa0b806b5cf448110a5cf3f293ff6cf177d1923f4ea9"} build_url:https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/bmEfxRwETwibdt0c0lHE3Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/2f1c5b06b756c479a90a0631341c4c40e9da9b947dc09af32f45e2efd0a18b2b6d422288eb7ac49e4f58ad696763234e9f80b8652e727c864a227dc39f8efc3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3488e728959686d11955967dca7583e9e92d4ab8a25868467f573f85922f027ae7e5d3be520c961e83e99e6002a35e62f3e8417d406e0141ba8709d217964686", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9cca6adfd5f67c1b3c9a25c1273b303a2036db2dc2129d96d578cf0da3c8f7340831914bdd02d685a131fa0b806b5cf448110a5cf3f293ff6cf177d1923f4ea9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 20:36:54.832326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:36:54.832646) ========= 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=3836458cccd887f2d2de3cf1000001de-1479787711.880475-205739202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:36:54.915217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 20:36:54.918588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 20:36:54.918894) ========= ========= Total master_lag: 0.18 =========